[65.396687] Initializing watchdogs
[65.396828]   /dev/watchdog0
[65.413270] [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]
[65.418570] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[65.420982] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.424364] [001/154] (960s left) gem_softpin (softpin)
[65.511616] Starting subtest: softpin
[97.805104] Subtest softpin: SUCCESS (32.226s)
[97.911730] [002/154] (928s left) kms_async_flips (test-cursor-atomic)
[98.017748] Starting subtest: test-cursor-atomic
[99.146869] Starting dynamic subtest: pipe-A-eDP-1
[99.621497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.474s)
[99.991154] Starting dynamic subtest: pipe-B-eDP-1
[100.752296] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.769s)
[101.131844] Starting dynamic subtest: pipe-C-eDP-1
[101.882933] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.760s)
[102.255610] Starting dynamic subtest: pipe-D-eDP-1
[103.012144] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s)
[103.014559] Subtest test-cursor-atomic: SUCCESS (4.994s)
[104.183769] [003/154] (921s left) gem_ctx_param (invalid-get-engines)
[104.245823] Starting subtest: invalid-get-engines
[104.248321] Subtest invalid-get-engines: SUCCESS (0.001s)
[104.374737] [004/154] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[104.472613] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[111.923073] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.453s)
[112.055116] [005/154] (914s left) kms_plane_scaling (planes-downscale-factor-0-5)
[112.151488] Starting subtest: planes-downscale-factor-0-5
[112.153683] Starting dynamic subtest: pipe-A
[112.175172] Dynamic subtest pipe-A: SKIP (0.019s)
[112.183191] Starting dynamic subtest: pipe-B
[112.208299] Dynamic subtest pipe-B: SKIP (0.033s)
[112.216733] Starting dynamic subtest: pipe-C
[112.242248] Dynamic subtest pipe-C: SKIP (0.033s)
[112.249974] Starting dynamic subtest: pipe-D
[112.273538] Dynamic subtest pipe-D: SKIP (0.033s)
[112.277780] Subtest planes-downscale-factor-0-5: SKIP (0.119s)
[112.387078] [006/154] (913s left) gem_exec_endless (dispatch)
[112.451114] Starting subtest: dispatch
[112.453579] Starting dynamic subtest: rcs0
[112.457972] Dynamic subtest rcs0: SUCCESS (0.005s)
[112.471044] Starting dynamic subtest: bcs0
[112.475652] Dynamic subtest bcs0: SUCCESS (0.004s)
[112.485586] Starting dynamic subtest: vcs0
[112.489770] Dynamic subtest vcs0: SUCCESS (0.004s)
[112.497586] Starting dynamic subtest: vcs1
[112.502383] Dynamic subtest vcs1: SUCCESS (0.004s)
[112.510124] Starting dynamic subtest: vecs0
[112.514242] Dynamic subtest vecs0: SUCCESS (0.004s)
[112.522061] Starting dynamic subtest: ccs0
[112.526256] Dynamic subtest ccs0: SUCCESS (0.005s)
[112.528431] Subtest dispatch: SUCCESS (0.029s)
[114.372795] [007/154] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[114.473937] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[121.498444] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.027s)
[121.633597] [008/154] (904s left) gem_userptr_blits (map-fixed-invalidate-busy)
[121.703240] Starting subtest: map-fixed-invalidate-busy
[121.708074] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[121.835060] [009/154] (904s left) gem_workarounds (reset-fd)
[121.910423] Starting subtest: reset-fd
[122.091083] Subtest reset-fd: SUCCESS (0.180s)
[122.211721] [010/154] (904s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[122.594698] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[123.399037] [011/154] (902s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary)
[123.501745] Starting subtest: fbcpsrhdr-indfb-scaledprimary
[123.505871] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s)
[123.593998] [012/154] (902s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[123.702569] Starting subtest: basic-flip-before-cursor-varying-size
[124.655125] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.949s)
[125.456615] [013/154] (900s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-render)
[125.563462] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-render
[125.567690] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[125.656832] [014/154] (900s left) kms_prime (basic-crc-vgem)
[125.805303] Starting subtest: basic-crc-vgem
[125.807459] Starting dynamic subtest: second-to-first
[126.806131] Dynamic subtest second-to-first: SUCCESS (1.002s)
[126.808138] Subtest basic-crc-vgem: SUCCESS (1.002s)
[126.900096] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[126.902717] [015/154] (899s left) kms_chamelium_audio (dp-audio-edid)
[127.306713] Subtest dp-audio-edid: SKIP (0.000s)
[128.164584] [016/154] (898s left) gem_tiled_partial_pwrite_pread (reads)
[128.231280] Subtest reads: SKIP (0.000s)
[128.303053] [017/154] (898s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[128.401754] Starting subtest: yf-tiled-64bpp-rotate-180
[128.406225] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[128.508085] [018/154] (898s left) kms_plane_multiple (2x-tiling-yf)
[128.599178] Starting subtest: 2x-tiling-yf
[128.603295] Subtest 2x-tiling-yf: SKIP (0.000s)
[128.679897] [019/154] (897s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-plflip-blt)
[128.777821] Starting subtest: hdr-1p-primscrn-indfb-plflip-blt
[128.782132] Subtest hdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[128.868398] [020/154] (897s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[128.980102] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[128.984609] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[129.075657] [021/154] (897s left) gem_userptr_blits (sd-probe)
[129.136902] Starting subtest: sd-probe
[129.138662] Subtest sd-probe: SUCCESS (0.000s)
[129.276363] [022/154] (897s left) i915_query (query-regions-unallocated)
[129.330752] Starting subtest: query-regions-unallocated
[129.332539] Subtest query-regions-unallocated: SUCCESS (0.000s)
[129.438765] [023/154] (897s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[129.532580] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[129.536213] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[129.627724] [024/154] (897s left) kms_chamelium_frames (hdmi-crc-single)
[130.003785] Subtest hdmi-crc-single: SKIP (0.000s)
[130.785905] [025/154] (896s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[130.894091] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[130.898039] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[130.993181] [026/154] (895s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move)
[131.096118] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move
[131.100182] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[131.206309] [027/154] (895s left) kms_vblank (crtc-id)
[131.293276] Starting subtest: crtc-id
[131.295434] Starting dynamic subtest: pipe-A-eDP-1
[131.741289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s)
[131.755750] Starting dynamic subtest: pipe-D-eDP-1
[132.860926] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.116s)
[132.863212] Subtest crtc-id: SUCCESS (1.567s)
[133.694484] [028/154] (893s left) kms_cursor_crc (cursor-offscreen-512x512)
[133.971570] Starting subtest: cursor-offscreen-512x512
[133.976268] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[134.140737] [029/154] (892s left) i915_drm_fdinfo (memory-info-purgeable)
[134.179105] Starting subtest: memory-info-purgeable
[134.181437] Starting dynamic subtest: smem0
[136.713737] Dynamic subtest smem0: SUCCESS (2.536s)
[136.716345] Subtest memory-info-purgeable: SUCCESS (2.537s)
[136.789874] [030/154] (890s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[136.886841] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[144.264400] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.382s)
[144.400988] [031/154] (882s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[144.502481] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[144.506587] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[144.588597] [032/154] (882s left) kms_cursor_edge_walk (64x64-left-edge)
[144.669632] Starting subtest: 64x64-left-edge
[144.671753] Starting dynamic subtest: pipe-A-eDP-1
[148.098246] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.429s)
[148.108186] Starting dynamic subtest: pipe-D-eDP-1
[151.235721] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[151.238094] Subtest 64x64-left-edge: SUCCESS (6.566s)
[152.045271] [033/154] (875s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[152.156548] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[152.979947] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.826s)
[153.185908] [034/154] (874s left) gem_exec_nop (basic-parallel)
[153.260471] Starting subtest: basic-parallel
[168.351943] Subtest basic-parallel: SUCCESS (15.100s)
[168.580222] [035/154] (858s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[168.683963] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[168.686267] Starting dynamic subtest: pipe-A-default-mode
[169.821323] Dynamic subtest pipe-A-default-mode: SKIP (1.136s)
[169.825846] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.137s)
[169.954545] [036/154] (857s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[170.053081] Starting subtest: y-tiled-addfb-size-offset-overflow
[170.057483] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[170.163968] [037/154] (857s left) gem_render_copy (yf-tiled-to-vebox-linear)
[170.223648] Starting subtest: yf-tiled-to-vebox-linear
[170.228137] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[170.408129] [038/154] (856s left) gem_mmap_offset (partial-mmap)
[170.460383] Starting subtest: partial-mmap
[170.462723] Starting dynamic subtest: smem0
[170.464918] Dynamic subtest smem0: SUCCESS (0.004s)
[170.466838] Subtest partial-mmap: SUCCESS (0.004s)
[170.578720] [039/154] (856s left) syncobj_timeline (signal-array)
[170.628597] Starting subtest: signal-array
[170.630728] Subtest signal-array: SUCCESS (0.000s)
[170.721814] [040/154] (856s left) api_intel_bb (purge-bb)
[170.780336] Starting subtest: purge-bb
[170.782703] Subtest purge-bb: SUCCESS (0.003s)
[170.904323] [041/154] (856s left) gem_eio (in-flight-contexts-immediate)
[171.133350] Starting subtest: in-flight-contexts-immediate
[184.387858] Subtest in-flight-contexts-immediate: SUCCESS (13.253s)
[184.509728] [042/154] (843s left) syncobj_eventfd (binary-wait-before-signal)
[184.561580] Starting subtest: binary-wait-before-signal
[184.591817] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[184.669443] [043/154] (842s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[184.767632] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[193.748402] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.987s)
[193.875292] [044/154] (833s left) device_reset (cold-reset-bound)
[193.922753] Starting subtest: cold-reset-bound
[193.927407] Subtest cold-reset-bound: SKIP (0.000s)
[194.006709] [045/154] (833s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[194.100941] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[194.105292] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[195.242311] [046/154] (832s left) kms_psr (psr2-cursor-mmap-cpu)
[195.339355] Starting subtest: psr2-cursor-mmap-cpu
[195.341850] Starting dynamic subtest: eDP-1
[197.017822] Dynamic subtest eDP-1: SUCCESS (1.678s)
[197.019816] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.678s)
[197.902287] [047/154] (829s left) gem_ctx_engines (invalid-engines)
[197.960824] Starting subtest: invalid-engines
[197.970121] Subtest invalid-engines: SUCCESS (0.009s)
[198.192124] [048/154] (829s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt)
[198.295626] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt
[198.299945] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[198.402152] [049/154] (829s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[198.490577] Starting subtest: psr-rgb101010-draw-mmap-wc
[205.593349] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.107s)
[205.715591] [050/154] (822s left) gem_exec_reloc (basic-wc)
[205.776446] Subtest basic-wc: SKIP (0.000s)
[205.860082] [051/154] (822s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[205.957307] Starting subtest: fbcpsr-shrfb-scaledprimary
[211.745189] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.792s)
[211.894357] [052/154] (816s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[211.999104] Starting subtest: psr2-cursor-plane-move-continuous-sf
[212.001390] Starting dynamic subtest: pipe-A-eDP-1
[222.350180] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.351s)
[222.359182] Starting dynamic subtest: pipe-B-eDP-1
[233.430578] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.078s)
[233.432978] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.432s)
[234.337421] [053/154] (793s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[234.434668] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[240.778942] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.349s)
[241.940372] [054/154] (786s left) kms_scaling_modes (scaling-mode-none)
[242.039111] Starting subtest: scaling-mode-none
[242.041516] Starting dynamic subtest: pipe-A-eDP-1
[242.136319] Dynamic subtest pipe-A-eDP-1: SKIP (0.096s)
[242.147898] Starting dynamic subtest: pipe-B-eDP-1
[242.170141] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s)
[242.179181] Starting dynamic subtest: pipe-C-eDP-1
[242.204650] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[242.216426] Starting dynamic subtest: pipe-D-eDP-1
[242.240089] Dynamic subtest pipe-D-eDP-1: SKIP (0.034s)
[242.244451] Subtest scaling-mode-none: SKIP (0.201s)
[242.362989] [055/154] (785s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-pwrite)
[242.474510] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-pwrite
[242.479056] Subtest hdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[242.556440] [056/154] (785s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[242.658090] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[242.755168] [057/154] (785s left) kms_vblank (invalid)
[242.845365] Starting subtest: invalid
[242.847076] Starting dynamic subtest: pipe-A-eDP-1
[243.244116] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[243.246199] Subtest invalid: SUCCESS (0.397s)
[244.068905] [058/154] (784s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[244.157778] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[244.162104] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[245.305879] [059/154] (782s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[245.404065] Starting subtest: bad-rotation-90-yf-tiled-ccs
[245.406305] Starting dynamic subtest: pipe-A-eDP-1
[245.429194] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[245.440190] Starting dynamic subtest: pipe-B-eDP-1
[245.461283] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[245.469368] Starting dynamic subtest: pipe-C-eDP-1
[245.490860] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[245.499093] Starting dynamic subtest: pipe-D-eDP-1
[245.521340] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[245.525595] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s)
[247.662703] [060/154] (780s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[247.710268] Starting subtest: etime-multi-wait-for-submit-submitted
[247.818975] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[247.908194] [061/154] (780s left) kms_plane_cursor (viewport)
[248.016656] Starting subtest: viewport
[248.020862] Starting dynamic subtest: pipe-A-eDP-1-size-64
[250.629845] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.614s)
[250.689583] Starting dynamic subtest: pipe-A-eDP-1-size-128
[253.287366] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.605s)
[253.345843] Starting dynamic subtest: pipe-A-eDP-1-size-256
[255.944176] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.605s)
[256.293190] Starting dynamic subtest: pipe-B-eDP-1-size-64
[259.572173] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.291s)
[259.632130] Starting dynamic subtest: pipe-B-eDP-1-size-128
[262.241277] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.617s)
[262.299074] Starting dynamic subtest: pipe-B-eDP-1-size-256
[264.908538] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.617s)
[265.256857] Starting dynamic subtest: pipe-C-eDP-1-size-64
[268.235072] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.993s)
[268.273095] Starting dynamic subtest: pipe-C-eDP-1-size-128
[270.490443] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.225s)
[270.528704] Starting dynamic subtest: pipe-C-eDP-1-size-256
[272.746361] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.225s)
[273.082417] Starting dynamic subtest: pipe-D-eDP-1-size-64
[276.041762] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.971s)
[276.079180] Starting dynamic subtest: pipe-D-eDP-1-size-128
[278.319196] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.247s)
[278.356235] Starting dynamic subtest: pipe-D-eDP-1-size-256
[280.563097] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[280.886853] Subtest viewport: SUCCESS (32.870s)
[281.693838] [062/154] (746s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[281.789938] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[288.513600] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.729s)
[288.650989] [063/154] (739s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-onoff)
[288.761159] Starting subtest: psrhdr-1p-primscrn-cur-indfb-onoff
[288.765468] Subtest psrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[288.853865] [064/154] (739s left) gem_softpin (allocator-evict)
[288.913043] Starting subtest: allocator-evict
[288.915314] Starting dynamic subtest: rcs0
[312.116404] Dynamic subtest rcs0: SUCCESS (23.205s)
[312.127701] Starting dynamic subtest: bcs0
[335.657529] Dynamic subtest bcs0: SUCCESS (23.542s)
[335.668509] Starting dynamic subtest: vcs0
[359.344391] Dynamic subtest vcs0: SUCCESS (23.687s)
[359.353744] Starting dynamic subtest: vcs1
[383.351852] Dynamic subtest vcs1: SUCCESS (24.006s)
[383.361902] Starting dynamic subtest: vecs0
[407.074309] Dynamic subtest vecs0: SUCCESS (23.720s)
[407.084316] Starting dynamic subtest: ccs0
[430.626345] Dynamic subtest ccs0: SUCCESS (23.549s)
[430.628716] Subtest allocator-evict: SUCCESS (141.717s)
[430.711286] [065/154] (597s left) gem_lmem_swapping (heavy-verify-multi)
[430.776634] Subtest heavy-verify-multi: SKIP (0.000s)
[430.823681] [066/154] (597s left) gem_mmap_gtt (basic-write-read-distinct)
[430.874230] Subtest basic-write-read-distinct: SKIP (0.000s)
[430.939695] [067/154] (597s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[431.283908] Starting subtest: cursor-rapid-movement-max-size
[431.290358] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[431.414603] [068/154] (597s left) gem_exec_schedule (semaphore-codependency)
[431.484854] Starting subtest: semaphore-codependency
[431.490451] Subtest semaphore-codependency: SUCCESS (0.013s)
[431.818873] [069/154] (596s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[431.921686] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[431.925715] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[432.019387] [070/154] (596s left) syncobj_wait (single-wait-for-submit-signaled)
[432.075991] Starting subtest: single-wait-for-submit-signaled
[432.078168] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[432.196579] [071/154] (596s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[432.299457] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[432.303412] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[432.387089] [072/154] (596s left) i915_hangman (gt-engine-error)
[432.453825] Starting subtest: gt-engine-error
[432.456075] Starting dynamic subtest: rcs0
[434.303220] Dynamic subtest rcs0: SUCCESS (1.849s)
[434.317174] Starting dynamic subtest: bcs0
[436.285360] Dynamic subtest bcs0: SUCCESS (1.979s)
[436.297891] Starting dynamic subtest: vcs0
[438.269565] Dynamic subtest vcs0: SUCCESS (1.982s)
[438.280047] Starting dynamic subtest: vcs1
[440.318281] Dynamic subtest vcs1: SUCCESS (2.045s)
[440.330893] Starting dynamic subtest: vecs0
[442.300705] Dynamic subtest vecs0: SUCCESS (1.980s)
[442.313773] Starting dynamic subtest: ccs0
[444.285471] Dynamic subtest ccs0: SUCCESS (1.981s)
[444.288339] Subtest gt-engine-error: SUCCESS (11.833s)
[444.369615] [073/154] (584s left) kms_flip_tiling (flip-change-tiling)
[444.475064] Starting subtest: flip-change-tiling
[444.477732] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[444.672539] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.198s)
[444.690045] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[444.817927] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[444.830075] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[444.962573] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[444.977566] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[445.106029] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[445.119405] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[445.260885] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.153s)
[445.276545] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[445.404831] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[445.418652] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[445.538904] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[445.550749] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[445.660983] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.119s)
[445.675730] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[445.806980] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[445.819030] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[445.950783] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.141s)
[445.964434] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[446.094154] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[446.107782] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[446.238673] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[446.251702] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[446.372727] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[446.385749] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[446.506807] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[446.519238] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[446.627709] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s)
[446.640518] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[446.772597] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[446.785046] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[446.927630] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.153s)
[446.939978] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[447.072058] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[447.084732] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[447.217243] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[447.230411] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[447.361659] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[447.374560] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[447.506260] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[447.521642] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[447.627856] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[447.641129] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[447.772020] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[447.784980] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[447.916557] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[447.928553] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[448.060419] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[448.074154] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[448.204748] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[448.219281] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[448.349629] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[448.362923] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[448.505014] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.153s)
[448.520576] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[448.627805] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[448.642883] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[448.783737] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.153s)
[448.797674] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[448.927559] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[448.942067] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[449.071868] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[449.086267] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[449.216604] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[449.228943] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[449.371780] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.153s)
[449.384047] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[449.516902] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[449.528334] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[449.638501] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[449.691345] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[450.974077] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.289s)
[450.986079] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[451.119354] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[451.130864] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[451.252752] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[451.265794] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[451.395988] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.140s)
[451.408924] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[451.539726] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[451.555325] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[451.684354] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.141s)
[451.695750] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[451.829702] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s)
[451.842196] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[451.951644] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.120s)
[451.963315] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[452.085712] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[452.099775] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[452.229450] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[452.242248] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[452.373980] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[452.387269] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[452.517853] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[452.529162] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[452.662651] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.142s)
[452.674883] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[452.808529] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s)
[452.822292] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[452.929670] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.119s)
[452.944410] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[453.074252] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[453.087514] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[453.217642] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[453.231669] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[453.374083] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.153s)
[453.386772] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[453.518677] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[453.532729] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[453.663904] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[453.677042] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[453.807477] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[453.820616] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[453.928664] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[453.940580] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[454.073187] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[454.086741] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[454.228620] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.153s)
[454.245395] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[454.373052] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[454.387741] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[454.517498] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[454.530446] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[454.650553] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.131s)
[454.665635] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[454.795299] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[454.808306] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[454.929331] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.131s)
[454.941585] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[455.079453] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.147s)
[455.092352] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[455.211477] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.131s)
[455.224573] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[455.334046] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.119s)
[455.347607] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[455.467228] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.131s)
[455.478248] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[455.611768] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[455.627345] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[455.756785] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[455.769534] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[455.889944] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.131s)
[455.942960] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[457.214563] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.278s)
[457.227126] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[457.314499] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[457.325207] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[457.414543] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[457.426897] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[457.525843] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[457.537871] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[457.637620] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[457.648627] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[457.747527] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[457.759276] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[457.847988] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[457.863886] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[457.947737] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[457.959628] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[458.047883] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[458.059067] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[458.158370] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[458.174672] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[458.269173] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[458.283112] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[458.402332] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.131s)
[458.417777] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[458.503263] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.097s)
[458.518731] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[458.602931] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[458.614366] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[458.702785] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[458.714737] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[458.814036] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[458.826974] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[458.924836] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[458.936789] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[459.036055] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[459.048328] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[459.147675] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[459.160485] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[459.258878] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[459.271489] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[459.358961] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[459.371579] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[459.469690] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[459.483757] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[459.580337] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.108s)
[459.592177] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[459.691249] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[459.703543] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[459.802554] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[459.814944] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[459.902538] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[459.914978] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[460.014131] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[460.026347] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[460.124995] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[460.138158] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[460.275020] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.149s)
[460.291388] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[460.386053] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.108s)
[460.398266] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[460.496771] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[460.511499] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[460.608059] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[460.623189] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[460.718947] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.108s)
[460.732866] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[460.841247] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.120s)
[460.853408] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[460.963785] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.121s)
[460.974589] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[461.074969] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[461.117094] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[462.347476] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.237s)
[462.360773] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[462.459061] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[462.471839] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[462.559055] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[462.571918] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[462.670017] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[462.682780] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[462.818980] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.147s)
[462.831767] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[462.930224] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[462.942801] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[463.030229] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[463.042061] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[463.130558] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[463.141756] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[463.230325] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[463.242103] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[463.341428] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[463.353923] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[463.452205] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[463.462352] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[463.563067] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[463.574806] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[463.663853] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[463.679505] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[463.763778] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.097s)
[463.775910] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[463.863554] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[463.875222] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[463.974480] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[463.986757] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[464.085145] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[464.098643] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[464.207319] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.120s)
[464.219376] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[464.307466] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s)
[464.322681] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[464.419296] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[464.431499] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[464.519583] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[464.531628] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[464.630632] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[464.643091] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[464.741149] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[464.753140] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[464.852189] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s)
[464.866820] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[464.963399] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[464.978395] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[465.074324] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[465.087343] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[465.185270] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[465.197134] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[465.296237] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s)
[465.307981] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[465.407873] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[465.422694] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[465.530195] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.118s)
[465.542918] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[465.641110] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[465.653478] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[465.752336] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[465.765858] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[465.863252] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[465.874952] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[465.974201] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s)
[465.985961] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[466.085955] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[466.096349] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[466.197040] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[466.229722] Subtest flip-change-tiling: SUCCESS (21.756s)
[467.447813] [074/154] (561s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[467.563145] Starting subtest: yf-tiled-16bpp-rotate-270
[467.567799] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[467.666423] [075/154] (561s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[467.724524] Starting subtest: x-tiled-to-vebox-y-tiled
[467.728974] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[467.907853] [076/154] (561s left) gem_ctx_param (non-root-set)
[467.962077] Starting subtest: non-root-set
[467.989501] Subtest non-root-set: SUCCESS (0.027s)
[468.076714] [077/154] (560s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[468.165675] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[468.170035] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[469.268877] [078/154] (559s left) kms_frontbuffer_tracking (fbc-2p-rte)
[469.365454] Starting subtest: fbc-2p-rte
[469.369660] Subtest fbc-2p-rte: SKIP (0.000s)
[469.470057] [079/154] (559s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[469.536623] Starting subtest: wait-all-for-submit-delayed-submit
[469.638024] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[469.715811] [080/154] (559s left) gem_exec_whisper (basic-forked-all)
[469.789324] Starting subtest: basic-forked-all
[483.296084] Subtest basic-forked-all: SUCCESS (13.502s)
[483.493239] [081/154] (545s left) gem_ppgtt (shrink-vs-evict-pinned)
[483.557879] Starting subtest: shrink-vs-evict-pinned
[491.278899] Subtest shrink-vs-evict-pinned: SUCCESS (7.721s)
[491.368047] [082/154] (537s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render)
[491.464768] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render
[491.468778] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[491.572662] [083/154] (537s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[491.670867] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[491.674974] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[491.764334] [084/154] (537s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[491.857981] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[491.862477] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[491.955812] [085/154] (537s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[492.051257] Starting subtest: plane-ctm3x4-lut1d
[492.220532] Starting dynamic subtest: pipe-A-plane-0
[492.419507] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[492.429884] Starting dynamic subtest: pipe-A-plane-1
[492.586363] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[492.598062] Starting dynamic subtest: pipe-A-plane-2
[492.752669] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[493.985899] Starting dynamic subtest: pipe-B-plane-0
[494.154225] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[494.165062] Starting dynamic subtest: pipe-B-plane-1
[494.343258] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[494.354643] Starting dynamic subtest: pipe-B-plane-2
[494.521443] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[495.708223] Starting dynamic subtest: pipe-C-plane-0
[495.843101] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[495.853658] Starting dynamic subtest: pipe-C-plane-1
[496.010314] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[496.020671] Starting dynamic subtest: pipe-C-plane-2
[496.165529] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[497.344480] Starting dynamic subtest: pipe-D-plane-0
[497.502972] Dynamic subtest pipe-D-plane-0: SUCCESS (0.165s)
[497.518777] Starting dynamic subtest: pipe-D-plane-1
[497.654986] Dynamic subtest pipe-D-plane-1: SUCCESS (0.154s)
[497.666496] Starting dynamic subtest: pipe-D-plane-2
[497.810620] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[498.101258] Subtest plane-ctm3x4-lut1d: SUCCESS (6.049s)
[498.909899] [086/154] (530s left) kms_vrr (flip-basic-fastset)
[499.001063] Starting subtest: flip-basic-fastset
[499.007164] Subtest flip-basic-fastset: SKIP (0.000s)
[499.102090] [087/154] (530s left) core_setmaster_vs_auth
[499.258823] [088/154] (530s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[499.356866] Starting subtest: fbc-tiling-linear
[503.025716] Subtest fbc-tiling-linear: SUCCESS (3.676s)
[504.236111] [089/154] (525s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[504.331980] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[504.336489] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[504.406380] [090/154] (525s left) kms_mmap_write_crc (main)
[504.497786] Starting subtest: main
[504.500203] Starting dynamic subtest: pipe-A-eDP-1
[508.060729] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.559s)
[508.062634] Subtest main: SUCCESS (3.560s)
[508.863677] [091/154] (520s left) gem_exec_await (wide-all)
[509.077493] Starting subtest: wide-all
[532.050261] Subtest wide-all: SUCCESS (22.969s)
[532.241712] [092/154] (497s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[532.407769] Starting subtest: cursorA-vs-flipA-atomic-transitions
[543.605763] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.196s)
[544.497149] [093/154] (485s left) perf_pmu (rc6-suspend)
[544.542662] Starting subtest: rc6-suspend
[566.889180] Subtest rc6-suspend: SUCCESS (8.762s)
[571.785516] [094/154] (461s left) syncobj_timeline (wait-all-complex)
[571.860990] Starting subtest: wait-all-complex
[572.079864] Subtest wait-all-complex: SUCCESS (0.217s)
[572.162240] [095/154] (461s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt)
[572.261493] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt
[572.265922] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[572.383609] [096/154] (461s left) kms_flip (2x-busy-flip)
[572.487866] Starting subtest: 2x-busy-flip
[572.496106] Subtest 2x-busy-flip: SKIP (0.011s)
[572.579282] [097/154] (461s left) kms_flip (2x-plain-flip-fb-recreate)
[572.669723] Starting subtest: 2x-plain-flip-fb-recreate
[572.679693] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[572.765451] [098/154] (461s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[572.872551] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[576.669775] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.655s)
[577.893506] [099/154] (456s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[577.995495] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[577.999933] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[578.069146] [100/154] (455s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[578.165335] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[585.433396] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.154s)
[585.558829] [101/154] (448s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[585.656724] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[586.286830] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.626s)
[586.442346] [102/154] (447s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[586.539546] Starting subtest: pipe-fbc-rte
[586.547032] Starting dynamic subtest: pipe-B-eDP-1
[592.054744] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.486s)
[592.062444] Subtest pipe-fbc-rte: SUCCESS (5.488s)
[594.357095] [103/154] (439s left) gem_exec_schedule (preemptive-hang)
[594.534148] Starting subtest: preemptive-hang
[594.536511] Starting dynamic subtest: rcs0
[604.057875] Dynamic subtest rcs0: SUCCESS (9.506s)
[604.071303] Starting dynamic subtest: bcs0
[613.014469] Dynamic subtest bcs0: SUCCESS (8.951s)
[613.027125] Starting dynamic subtest: vcs0
[622.037180] Dynamic subtest vcs0: SUCCESS (9.015s)
[622.050825] Starting dynamic subtest: vcs1
[631.063317] Dynamic subtest vcs1: SUCCESS (9.021s)
[631.075946] Starting dynamic subtest: vecs0
[640.080375] Dynamic subtest vecs0: SUCCESS (9.009s)
[640.094717] Starting dynamic subtest: ccs0
[649.115888] Dynamic subtest ccs0: SUCCESS (9.029s)
[649.118665] Subtest preemptive-hang: SUCCESS (54.541s)
[649.362495] [104/154] (384s left) gen9_exec_parse (batch-zero-length)
[649.420173] Subtest batch-zero-length: SKIP (0.000s)
[649.499221] [105/154] (384s left) kms_psr (fbc-psr2-basic)
[649.593741] Starting subtest: fbc-psr2-basic
[649.596005] Starting dynamic subtest: eDP-1
[649.600054] Dynamic subtest eDP-1: SKIP (0.000s)
[649.604072] Subtest fbc-psr2-basic: SKIP (0.001s)
[649.673098] [106/154] (384s left) kms_psr (fbc-pr-cursor-blt)
[649.767605] Starting subtest: fbc-pr-cursor-blt
[649.771879] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[649.843470] [107/154] (384s left) kms_plane (pixel-format-yf-tiled-modifier)
[649.941175] Starting subtest: pixel-format-yf-tiled-modifier
[649.945170] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[650.025685] [108/154] (384s left) syncobj_wait (wait-any-snapshot)
[650.076472] Starting subtest: wait-any-snapshot
[650.156708] Subtest wait-any-snapshot: SUCCESS (0.082s)
[650.250345] [109/154] (384s left) syncobj_wait (single-wait-signaled)
[650.306156] Starting subtest: single-wait-signaled
[650.308219] Subtest single-wait-signaled: SUCCESS (0.000s)
[650.405010] [110/154] (384s left) gem_blits (basic)
[650.469774] Starting subtest: basic
[651.854083] Subtest basic: SUCCESS (1.381s)
[651.971329] [111/154] (382s left) kms_properties (invalid-properties-atomic)
[652.058162] Starting subtest: invalid-properties-atomic
[652.357582] Subtest invalid-properties-atomic: SUCCESS (0.299s)
[652.434563] [112/154] (382s left) syncobj_eventfd (timeline-wait-signaled)
[652.492480] Starting subtest: timeline-wait-signaled
[652.494656] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[652.591371] [113/154] (382s left) kms_feature_discovery (psr1)
[652.691628] Starting subtest: psr1
[652.693935] Subtest psr1: SUCCESS (0.000s)
[652.768965] [114/154] (381s left) kms_content_protection (mei-interface)
[652.914652] Starting subtest: mei-interface
[652.919109] Subtest mei-interface: SKIP (0.001s)
[653.059135] [115/154] (381s left) gem_ctx_shared (detached-shared-gtt)
[653.107512] Starting subtest: detached-shared-gtt
[655.260778] Subtest detached-shared-gtt: SUCCESS (2.151s)
[655.647390] [116/154] (379s left) gem_sync (basic-all)
[655.722242] Starting subtest: basic-all
[658.924583] Subtest basic-all: SUCCESS (3.210s)
[659.138077] [117/154] (375s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[659.194756] Starting subtest: multi-wait-all-for-submit-unsubmitted
[659.296230] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[659.382359] [118/154] (375s left) kms_psr (fbc-psr-no-drrs)
[659.481634] Starting subtest: fbc-psr-no-drrs
[659.483894] Starting dynamic subtest: eDP-1
[659.488009] Dynamic subtest eDP-1: SKIP (0.000s)
[659.492163] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[659.556805] [119/154] (375s left) vgem_basic (dmabuf-fence-before)
[659.600036] Starting subtest: dmabuf-fence-before
[659.602205] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[659.656114] [120/154] (375s left) kms_pm_dc (dc5-dpms)
[660.750638] Starting subtest: dc5-dpms
[662.882388] Subtest dc5-dpms: SUCCESS (2.129s)
[662.961914] [121/154] (371s left) api_intel_allocator (fork-simple-stress)
[663.024452] Starting subtest: fork-simple-stress
[668.421812] Subtest fork-simple-stress: SUCCESS (5.398s)
[668.547799] [122/154] (366s left) gem_exec_reloc (basic-cpu-gtt-active)
[668.614265] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[668.714193] [123/154] (366s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[668.827309] Starting subtest: fbcpsr-2p-rte
[668.831366] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[668.925318] [124/154] (366s left) kms_psr (psr-cursor-mmap-cpu)
[669.029993] Starting subtest: psr-cursor-mmap-cpu
[669.032143] Starting dynamic subtest: eDP-1
[670.727999] Dynamic subtest eDP-1: SUCCESS (1.697s)
[670.729886] Subtest psr-cursor-mmap-cpu: SUCCESS (1.698s)
[671.597778] [125/154] (363s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[671.712060] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[671.716027] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[671.832542] [126/154] (363s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render)
[671.942697] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render
[671.947328] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[672.050552] [127/154] (363s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[672.161425] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[672.165452] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[672.285795] [128/154] (362s left) gem_exec_fence (keep-in-fence)
[672.471299] Starting subtest: keep-in-fence
[672.473948] Starting dynamic subtest: rcs0
[672.540263] Dynamic subtest rcs0: SUCCESS (0.069s)
[672.558123] Starting dynamic subtest: bcs0
[672.593654] Dynamic subtest bcs0: SUCCESS (0.052s)
[672.607477] Starting dynamic subtest: vcs0
[673.906054] Dynamic subtest vcs0: SUCCESS (1.309s)
[673.920733] Starting dynamic subtest: vcs1
[675.885192] Dynamic subtest vcs1: SUCCESS (1.978s)
[675.898167] Starting dynamic subtest: vecs0
[677.933033] Dynamic subtest vecs0: SUCCESS (2.046s)
[677.946925] Starting dynamic subtest: ccs0
[678.165251] Dynamic subtest ccs0: SUCCESS (0.231s)
[678.168195] Subtest keep-in-fence: SUCCESS (5.698s)
[680.018262] [129/154] (355s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-pgflip-blt)
[680.123111] Starting subtest: psrhdr-2p-primscrn-shrfb-pgflip-blt
[680.127203] Subtest psrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[680.223105] [130/154] (355s left) perf_pmu (busy)
[680.259225] Starting subtest: busy
[680.261418] Starting dynamic subtest: rcs0
[680.844133] Dynamic subtest rcs0: SUCCESS (0.585s)
[680.858384] Starting dynamic subtest: bcs0
[681.405888] Dynamic subtest bcs0: SUCCESS (0.560s)
[681.420015] Starting dynamic subtest: vcs0
[682.924759] Dynamic subtest vcs0: SUCCESS (1.516s)
[682.939242] Starting dynamic subtest: vcs1
[684.908669] Dynamic subtest vcs1: SUCCESS (1.981s)
[684.922826] Starting dynamic subtest: vecs0
[686.892874] Dynamic subtest vecs0: SUCCESS (1.982s)
[686.906267] Starting dynamic subtest: ccs0
[687.460379] Dynamic subtest ccs0: SUCCESS (0.567s)
[687.463051] Subtest busy: SUCCESS (7.204s)
[687.571259] [131/154] (347s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-wc)
[687.684441] Starting subtest: psrhdr-rgb101010-draw-mmap-wc
[687.688501] Subtest psrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[687.791118] [132/154] (347s left) sysfs_heartbeat_interval (precise)
[687.844211] Starting subtest: precise
[687.846578] Starting dynamic subtest: vecs0
[694.893039] Dynamic subtest vecs0: SUCCESS (7.046s)
[694.905687] Starting dynamic subtest: ccs0
[695.951033] Dynamic subtest ccs0: SUCCESS (1.057s)
[695.961867] Starting dynamic subtest: vcs0
[703.920191] Dynamic subtest vcs0: SUCCESS (7.968s)
[703.934425] Starting dynamic subtest: bcs0
[704.997597] Dynamic subtest bcs0: SUCCESS (1.073s)
[705.012468] Starting dynamic subtest: rcs0
[706.080931] Dynamic subtest rcs0: SUCCESS (1.083s)
[706.094443] Starting dynamic subtest: vcs1
[713.909105] Dynamic subtest vcs1: SUCCESS (7.827s)
[713.912324] Subtest precise: SUCCESS (26.065s)
[713.992156] [133/154] (321s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render)
[714.103748] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render
[714.108117] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[714.205537] [134/154] (321s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[714.317265] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[746.191762] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.864s)
[747.026957] [135/154] (288s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[747.137717] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[747.141946] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[747.234190] [136/154] (288s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[747.338554] Starting subtest: x-tiled-16bpp-rotate-180
[748.685152] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.346s)
[748.813817] [137/154] (286s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[748.873108] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[748.934433] [138/154] (286s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[749.030624] Starting subtest: hdr-modesetfrombusy
[749.034242] Subtest hdr-modesetfrombusy: SKIP (0.000s)
[749.132050] [139/154] (286s left) i915_pm_rpm (reg-read-ioctl)
[751.067447] Starting subtest: reg-read-ioctl
[753.477617] Subtest reg-read-ioctl: SUCCESS (2.412s)
[753.890875] [140/154] (281s left) kms_invalid_mode (bad-hsync-start)
[753.987008] Starting subtest: bad-hsync-start
[753.989273] Starting dynamic subtest: pipe-A-eDP-1
[754.271318] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[754.283383] Starting dynamic subtest: pipe-B-eDP-1
[754.285351] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[754.296843] Starting dynamic subtest: pipe-C-eDP-1
[754.299132] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[754.321456] Starting dynamic subtest: pipe-D-eDP-1
[754.324278] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[754.327081] Subtest bad-hsync-start: SUCCESS (0.291s)
[755.109739] [141/154] (280s left) gem_exec_suspend (basic-s3-devices)
[755.166776] Starting subtest: basic-S3-devices
[755.169395] Starting dynamic subtest: smem
[765.932717] Dynamic subtest smem: SUCCESS (10.760s)
[765.935728] Subtest basic-S3-devices: SUCCESS (10.762s)
[772.162325] [142/154] (269s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[772.261651] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[772.264021] Starting dynamic subtest: pipe-A-default-mode
[775.014874] Dynamic subtest pipe-A-default-mode: SUCCESS (2.751s)
[775.017073] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.752s)
[775.889128] [143/154] (266s left) gem_mmap_wc (invalid-flags)
[775.949382] Subtest invalid-flags: SKIP (0.000s)
[776.007426] [144/154] (266s left) gem_media_vme
[776.120557] [145/154] (265s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[776.175275] Starting subtest: invalid-single-wait-all-unsubmitted
[776.177575] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[776.285256] [146/154] (265s left) kms_hdmi_inject (inject-audio)
[776.651877] Starting subtest: inject-audio
[776.949167] Subtest inject-audio: SUCCESS (0.298s)
[777.570564] [147/154] (264s left) kms_pm_backlight (fade-with-dpms)
[777.676169] Starting subtest: fade-with-dpms
[779.869573] Starting dynamic subtest: eDP-1
[782.874918] Dynamic subtest eDP-1: SUCCESS (3.006s)
[782.877261] Subtest fade-with-dpms: SUCCESS (5.200s)
[783.733662] [148/154] (258s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[783.832193] Starting subtest: fbc-dirtyfb-ioctl
[783.834478] Starting dynamic subtest: A-eDP-1
[786.478387] Dynamic subtest A-eDP-1: SUCCESS (2.645s)
[786.480697] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.647s)
[787.321684] [149/154] (254s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[787.379368] Starting subtest: single-wait-all-for-submit-unsubmitted
[787.488807] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[787.570843] [150/154] (254s left) gem_exec_balancer (bonded-true-hang)
[787.837161] Starting subtest: bonded-true-hang
[787.842092] Subtest bonded-true-hang: SKIP (0.000s)
[787.948974] [151/154] (254s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[788.044450] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[788.048699] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[788.143290] [152/154] (254s left) gem_exec_reloc (basic-scanout)
[788.201857] Subtest basic-scanout: SKIP (0.000s)
[788.272392] [153/154] (254s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[788.375915] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[788.379813] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[788.492233] [154/154] (253s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[788.612032] Starting subtest: flip-vs-cursor-busy-crc-legacy
[789.341669] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.727s)
[790.221695] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: kms_async_flips
results: parsing output: 2/ for test: gem_ctx_param
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: gem_exec_endless
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: gem_workarounds
results: parsing output: 9/ for test: kms_chamelium_hpd
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_prime
results: parsing output: 14/ for test: kms_chamelium_audio
results: parsing output: 15/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_plane_multiple
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: i915_query
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_chamelium_frames
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: i915_drm_fdinfo
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_cursor_edge_walk
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_exec_nop
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_render_copy
results: parsing output: 37/ for test: gem_mmap_offset
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: api_intel_bb
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: syncobj_eventfd
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: device_reset
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: gem_ctx_engines
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_scaling_modes
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_addfb_basic
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_plane_cursor
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_softpin
results: parsing output: 64/ for test: gem_lmem_swapping
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: i915_hangman
results: parsing output: 72/ for test: kms_flip_tiling
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: gem_ctx_param
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: gem_ppgtt
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_color_pipeline
results: parsing output: 85/ for test: kms_vrr
results: parsing output: 86/ for test: core_setmaster_vs_auth
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_mmap_write_crc
results: parsing output: 90/ for test: gem_exec_await
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: perf_pmu
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_joiner
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: gen9_exec_parse
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: gem_blits
results: parsing output: 110/ for test: kms_properties
results: parsing output: 111/ for test: syncobj_eventfd
results: parsing output: 112/ for test: kms_feature_discovery
results: parsing output: 113/ for test: kms_content_protection
results: parsing output: 114/ for test: gem_ctx_shared
results: parsing output: 115/ for test: gem_sync
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: vgem_basic
results: parsing output: 119/ for test: kms_pm_dc
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: sysfs_heartbeat_interval
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_cursor_legacy
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_big_fb
results: parsing output: 136/ for test: kms_pipe_b_c_ivb
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: i915_pm_rpm
results: parsing output: 139/ for test: kms_invalid_mode
results: parsing output: 140/ for test: gem_exec_suspend
results: parsing output: 141/ for test: kms_flip_scaled_crc
results: parsing output: 142/ for test: gem_mmap_wc
results: parsing output: 143/ for test: gem_media_vme
results: parsing output: 144/ for test: syncobj_timeline
results: parsing output: 145/ for test: kms_hdmi_inject
results: parsing output: 146/ for test: kms_pm_backlight
results: parsing output: 147/ for test: kms_dirtyfb
results: parsing output: 148/ for test: syncobj_wait
results: parsing output: 149/ for test: gem_exec_balancer
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: gem_exec_reloc
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_cursor_legacy
Done.