[58.392398] Initializing watchdogs
[58.392446]   /dev/watchdog0
[58.406507] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.410749] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.413259] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.416744] [001/133] (960s left) kms_psr (fbc-psr2-cursor-blt)
[58.528087] Starting subtest: fbc-psr2-cursor-blt
[58.530240] Starting dynamic subtest: eDP-1
[58.534244] Dynamic subtest eDP-1: SKIP (0.000s)
[58.538341] Subtest fbc-psr2-cursor-blt: SKIP (0.000s)
[58.600599] [002/133] (960s left) gem_exec_balancer (parallel-bb-first)
[59.036156] Starting subtest: parallel-bb-first
[60.135017] Subtest parallel-bb-first: SUCCESS (1.097s)
[60.986467] [003/133] (958s left) kms_cursor_edge_walk (128x128-top-edge)
[61.075096] Starting subtest: 128x128-top-edge
[61.077543] Starting dynamic subtest: pipe-A-eDP-1
[64.572133] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.494s)
[64.582986] Starting dynamic subtest: pipe-D-eDP-1
[67.694995] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[67.697576] Subtest 128x128-top-edge: SUCCESS (6.616s)
[68.503048] [004/133] (950s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[68.601229] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[68.605738] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[68.669475] [005/133] (950s left) gem_exec_parallel (contexts)
[68.732391] Starting subtest: contexts
[68.734726] Starting dynamic subtest: rcs0
[71.715918] Dynamic subtest rcs0: SUCCESS (2.981s)
[71.727581] Starting dynamic subtest: bcs0
[74.940596] Dynamic subtest bcs0: SUCCESS (3.224s)
[74.948691] Starting dynamic subtest: vcs0
[79.357092] Dynamic subtest vcs0: SUCCESS (4.414s)
[79.367384] Starting dynamic subtest: vcs1
[83.454968] Dynamic subtest vcs1: SUCCESS (4.097s)
[83.463109] Starting dynamic subtest: vecs0
[87.422404] Dynamic subtest vecs0: SUCCESS (3.966s)
[87.433918] Starting dynamic subtest: ccs0
[90.985653] Dynamic subtest ccs0: SUCCESS (3.561s)
[90.988028] Subtest contexts: SUCCESS (22.248s)
[91.165250] [006/133] (927s left) gem_exec_schedule (u-semaphore-resolve)
[91.250577] Starting subtest: u-semaphore-resolve
[91.312695] Subtest u-semaphore-resolve: SUCCESS (0.063s)
[91.659151] [007/133] (927s left) gem_exec_gttfill (engines)
[91.722671] Starting subtest: engines
[91.725144] Starting dynamic subtest: rcs0
[115.330985] Dynamic subtest rcs0: SUCCESS (23.606s)
[115.342297] Starting dynamic subtest: bcs0
[138.690762] Dynamic subtest bcs0: SUCCESS (23.359s)
[138.698656] Starting dynamic subtest: vcs0
[162.047568] Dynamic subtest vcs0: SUCCESS (23.353s)
[162.056086] Starting dynamic subtest: vcs1
[185.346094] Dynamic subtest vcs1: SUCCESS (23.296s)
[185.357564] Starting dynamic subtest: vecs0
[208.666077] Dynamic subtest vecs0: SUCCESS (23.317s)
[208.677949] Starting dynamic subtest: ccs0
[231.897594] Dynamic subtest ccs0: SUCCESS (23.230s)
[231.900210] Subtest engines: SUCCESS (140.167s)
[232.078687] [008/133] (787s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[232.228508] Starting subtest: yf-tiled-16bpp-rotate-0
[232.233217] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[232.336500] [009/133] (786s left) kms_big_fb (4-tiled-addfb)
[232.437578] Starting subtest: 4-tiled-addfb
[232.439454] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[232.530196] [010/133] (786s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[232.618141] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[232.620462] Starting dynamic subtest: pipe-A-eDP-1
[233.384774] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.758s)
[233.394908] Starting dynamic subtest: pipe-B-eDP-1
[235.225548] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.840s)
[235.234270] Starting dynamic subtest: pipe-C-eDP-1
[237.049283] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.823s)
[237.059081] Starting dynamic subtest: pipe-D-eDP-1
[238.872751] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.822s)
[238.874668] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.247s)
[240.006631] [011/133] (779s left) kms_content_protection (mei-interface)
[240.177758] Starting subtest: mei-interface
[240.187780] Subtest mei-interface: SKIP (0.008s)
[240.303409] [012/133] (779s left) i915_suspend (fence-restore-untiled)
[240.351922] Starting subtest: fence-restore-untiled
[240.356412] Subtest fence-restore-untiled: SKIP (0.000s)
[240.458856] [013/133] (778s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[240.564883] Starting subtest: fbc-psr-cursor-mmap-cpu
[240.567358] Starting dynamic subtest: eDP-1
[240.571891] Dynamic subtest eDP-1: SKIP (0.000s)
[240.576468] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[240.634666] [014/133] (778s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[240.768324] Starting subtest: flip-vs-cursor-crc-legacy
[241.497061] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.728s)
[242.341359] [015/133] (777s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[242.441072] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[242.445236] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[242.525714] [016/133] (776s left) gem_mmap_gtt (basic-small-bo-tiledy)
[242.580787] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[242.632193] [017/133] (776s left) kms_pm_rpm (basic-rte)
[242.668027] Starting subtest: basic-rte
[245.621437] Subtest basic-rte: SUCCESS (2.952s)
[247.438316] [018/133] (772s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[247.489653] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[247.492118] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[247.573681] [019/133] (772s left) i915_drm_fdinfo (virtual-busy-idle)
[247.617569] Starting subtest: virtual-busy-idle
[247.621700] Subtest virtual-busy-idle: SKIP (0.000s)
[247.691622] [020/133] (771s left) kms_psr (pr-primary-render)
[247.792594] Starting subtest: pr-primary-render
[247.797093] Subtest pr-primary-render: SKIP (0.000s)
[247.867620] [021/133] (771s left) gem_exec_big (single)
[247.914147] Starting subtest: single
[252.667669] Subtest single: SUCCESS (4.752s)
[252.907179] [022/133] (766s left) i915_drm_fdinfo (busy-idle-check-all)
[252.988572] Starting subtest: busy-idle-check-all
[252.990434] Starting dynamic subtest: rcs0
[252.994608] Dynamic subtest rcs0: SKIP (0.006s)
[253.004057] Starting dynamic subtest: bcs0
[253.008109] Dynamic subtest bcs0: SKIP (0.000s)
[253.016476] Starting dynamic subtest: vcs0
[253.020862] Dynamic subtest vcs0: SKIP (0.000s)
[253.029200] Starting dynamic subtest: vcs1
[253.033220] Dynamic subtest vcs1: SKIP (0.000s)
[253.040899] Starting dynamic subtest: vecs0
[253.044965] Dynamic subtest vecs0: SKIP (0.000s)
[253.053056] Starting dynamic subtest: ccs0
[253.057310] Dynamic subtest ccs0: SKIP (0.000s)
[253.061596] Subtest busy-idle-check-all: SKIP (0.009s)
[253.100672] [023/133] (766s left) kms_async_flips (crc)
[253.230293] Starting subtest: crc
[253.606929] Starting dynamic subtest: pipe-A-eDP-1
[256.546185] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.938s)
[256.941875] Starting dynamic subtest: pipe-B-eDP-1
[259.873360] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.944s)
[260.255770] Starting dynamic subtest: pipe-C-eDP-1
[263.101551] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.856s)
[263.467154] Starting dynamic subtest: pipe-D-eDP-1
[266.329477] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.873s)
[266.331667] Subtest crc: SUCCESS (13.100s)
[267.488925] [024/133] (752s left) gem_userptr_blits (coherency-unsync)
[267.556332] Subtest coherency-unsync: SKIP (0.000s)
[267.671340] [025/133] (752s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[267.770432] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[267.774930] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[267.911892] [026/133] (751s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[268.014713] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[272.293461] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.284s)
[273.501815] [027/133] (746s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[273.605149] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[273.609156] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[273.671825] [028/133] (746s left) kms_feature_discovery (psr2)
[273.761069] Starting subtest: psr2
[273.763285] Subtest psr2: SUCCESS (0.000s)
[273.831402] [029/133] (746s left) kms_pm_rpm (pm-tiling)
[276.005358] Starting subtest: pm-tiling
[276.010641] Subtest pm-tiling: SKIP (0.000s)
[276.380269] [030/133] (743s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[276.478324] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[276.482640] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[276.586710] [031/133] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[276.688837] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[283.268055] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.583s)
[283.406577] [032/133] (736s left) kms_color (invalid-gamma-lut-sizes)
[283.509306] Starting subtest: invalid-gamma-lut-sizes
[283.511583] Starting dynamic subtest: pipe-A
[283.798772] Dynamic subtest pipe-A: SUCCESS (0.289s)
[283.808610] Starting dynamic subtest: pipe-B
[283.810988] Dynamic subtest pipe-B: SUCCESS (0.000s)
[283.819918] Starting dynamic subtest: pipe-C
[283.822393] Dynamic subtest pipe-C: SUCCESS (0.000s)
[283.831044] Starting dynamic subtest: pipe-D
[283.833668] Dynamic subtest pipe-D: SUCCESS (0.000s)
[283.835765] Subtest invalid-gamma-lut-sizes: SUCCESS (0.291s)
[284.639320] [033/133] (735s left) kms_dsc (dsc-basic)
[284.733467] Starting subtest: dsc-basic
[284.747171] Subtest dsc-basic: SKIP (0.000s)
[284.811469] [034/133] (735s left) gem_ctx_persistence (legacy-engines-persistence)
[284.872069] Starting subtest: legacy-engines-persistence
[284.874199] Starting dynamic subtest: render
[285.652630] Dynamic subtest render: SUCCESS (0.780s)
[285.664414] Starting dynamic subtest: bsd1
[286.426931] Dynamic subtest bsd1: SUCCESS (0.772s)
[286.440477] Starting dynamic subtest: bsd2
[287.183944] Dynamic subtest bsd2: SUCCESS (0.754s)
[287.195746] Starting dynamic subtest: blt
[287.931123] Dynamic subtest blt: SUCCESS (0.745s)
[287.942971] Starting dynamic subtest: vebox
[288.713993] Dynamic subtest vebox: SUCCESS (0.781s)
[288.716642] Subtest legacy-engines-persistence: SUCCESS (3.843s)
[288.792604] [035/133] (731s left) gem_ctx_param (invalid-get-ringsize)
[288.839961] Starting subtest: invalid-get-ringsize
[288.842398] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[288.955209] [036/133] (731s left) kms_psr (psr2-primary-mmap-cpu)
[289.053858] Starting subtest: psr2-primary-mmap-cpu
[289.056171] Starting dynamic subtest: eDP-1
[290.735448] Dynamic subtest eDP-1: SUCCESS (1.681s)
[290.737902] Subtest psr2-primary-mmap-cpu: SUCCESS (1.682s)
[291.632693] [037/133] (728s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[291.752966] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[291.756944] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[291.825058] [038/133] (728s left) gem_userptr_blits (unsync-overlap)
[291.895252] Subtest unsync-overlap: SKIP (0.000s)
[292.009401] [039/133] (728s left) kms_dirtyfb (default-dirtyfb-ioctl)
[292.099787] Starting subtest: default-dirtyfb-ioctl
[292.102055] Starting dynamic subtest: A-eDP-1
[293.731754] Dynamic subtest A-eDP-1: SUCCESS (1.632s)
[293.733889] Subtest default-dirtyfb-ioctl: SUCCESS (1.633s)
[294.550807] [040/133] (725s left) sysfs_heartbeat_interval (idempotent)
[294.619828] Starting subtest: idempotent
[294.622700] Starting dynamic subtest: vecs0
[294.625337] Dynamic subtest vecs0: SUCCESS (0.001s)
[294.635791] Starting dynamic subtest: ccs0
[294.638068] Dynamic subtest ccs0: SUCCESS (0.001s)
[294.646456] Starting dynamic subtest: vcs0
[294.648784] Dynamic subtest vcs0: SUCCESS (0.000s)
[294.657053] Starting dynamic subtest: bcs0
[294.659479] Dynamic subtest bcs0: SUCCESS (0.001s)
[294.667911] Starting dynamic subtest: rcs0
[294.670041] Dynamic subtest rcs0: SUCCESS (0.000s)
[294.681850] Starting dynamic subtest: vcs1
[294.684216] Dynamic subtest vcs1: SUCCESS (0.000s)
[294.686631] Subtest idempotent: SUCCESS (0.007s)
[294.721973] [041/133] (725s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[294.830891] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[295.943030] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.113s)
[296.052419] [042/133] (724s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[296.121995] Starting subtest: single-wait-all-for-submit-signaled
[296.124085] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[296.241100] [043/133] (724s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[296.346686] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[296.350170] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[296.410900] [044/133] (724s left) kms_async_flips (invalid-async-flip-atomic)
[296.507190] Starting subtest: invalid-async-flip-atomic
[296.881853] Starting dynamic subtest: pipe-A-eDP-1
[297.678672] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.797s)
[298.037219] Starting dynamic subtest: pipe-B-eDP-1
[298.817301] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.787s)
[299.174078] Starting dynamic subtest: pipe-C-eDP-1
[299.956721] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.789s)
[300.347295] Starting dynamic subtest: pipe-D-eDP-1
[301.195079] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.855s)
[301.197636] Subtest invalid-async-flip-atomic: SUCCESS (4.691s)
[302.400998] [045/133] (718s left) gem_softpin (evict-prime-sanity-check)
[302.463477] Starting subtest: evict-prime-sanity-check
[302.465810] Starting dynamic subtest: rcs0
[303.618242] Dynamic subtest rcs0: SUCCESS (1.157s)
[303.630509] Starting dynamic subtest: bcs0
[304.752984] Dynamic subtest bcs0: SUCCESS (1.133s)
[304.763842] Starting dynamic subtest: vcs0
[305.868612] Dynamic subtest vcs0: SUCCESS (1.114s)
[305.880973] Starting dynamic subtest: vcs1
[307.900013] Dynamic subtest vcs1: SUCCESS (2.028s)
[307.908817] Starting dynamic subtest: vecs0
[309.900079] Dynamic subtest vecs0: SUCCESS (1.998s)
[309.918331] Starting dynamic subtest: ccs0
[311.023521] Dynamic subtest ccs0: SUCCESS (1.122s)
[311.041734] Starting dynamic subtest: all
[312.140806] Dynamic subtest all: SUCCESS (1.115s)
[312.143773] Subtest evict-prime-sanity-check: SUCCESS (9.680s)
[312.270342] [046/133] (708s left) gem_ctx_param (basic-default)
[312.328225] Starting subtest: basic-default
[312.330887] Subtest basic-default: SUCCESS (0.000s)
[312.401652] [047/133] (708s left) kms_pipe_crc_basic (nonblocking-crc)
[312.522945] Starting subtest: nonblocking-crc
[312.524904] Starting dynamic subtest: pipe-A-eDP-1
[313.284674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.760s)
[313.293461] Starting dynamic subtest: pipe-B-eDP-1
[314.742719] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.456s)
[314.752786] Starting dynamic subtest: pipe-C-eDP-1
[316.097830] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s)
[316.115169] Starting dynamic subtest: pipe-D-eDP-1
[317.443817] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[317.446217] Subtest nonblocking-crc: SUCCESS (4.922s)
[318.248646] [048/133] (702s left) kms_flip (2x-absolute-wf_vblank)
[318.354563] Starting subtest: 2x-absolute-wf_vblank
[318.364080] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[318.439161] [049/133] (702s left) perf_pmu (invalid-init)
[318.481922] Starting subtest: invalid-init
[318.484617] Subtest invalid-init: SUCCESS (0.000s)
[318.579040] [050/133] (702s left) kms_addfb_basic (invalid-get-prop)
[318.632979] Starting subtest: invalid-get-prop
[318.635186] Subtest invalid-get-prop: SUCCESS (0.000s)
[318.774068] [051/133] (702s left) gem_exec_schedule (pi-shared-iova)
[318.946675] Starting subtest: pi-shared-iova
[318.948886] Starting dynamic subtest: rcs0
[319.019988] Dynamic subtest rcs0: SUCCESS (0.076s)
[319.032971] Starting dynamic subtest: vcs0
[319.081390] Dynamic subtest vcs0: SUCCESS (0.061s)
[319.092637] Starting dynamic subtest: vcs1
[319.137893] Dynamic subtest vcs1: SUCCESS (0.055s)
[319.146812] Starting dynamic subtest: vecs0
[319.192652] Dynamic subtest vecs0: SUCCESS (0.056s)
[319.203675] Starting dynamic subtest: ccs0
[319.252953] Dynamic subtest ccs0: SUCCESS (0.060s)
[319.255414] Subtest pi-shared-iova: SUCCESS (0.310s)
[321.042714] [052/133] (699s left) prime_mmap (test_forked)
[321.099058] Starting subtest: test_forked
[321.101220] Starting dynamic subtest: test_forked-smem
[321.136781] Dynamic subtest test_forked-smem: SUCCESS (0.038s)
[321.139439] Subtest test_forked: SUCCESS (0.040s)
[321.243395] [053/133] (699s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[321.336805] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[321.339082] Starting dynamic subtest: pipe-A
[321.672771] Dynamic subtest pipe-A: SUCCESS (0.338s)
[321.681854] Starting dynamic subtest: pipe-B
[323.045646] Dynamic subtest pipe-B: SUCCESS (1.372s)
[323.057707] Starting dynamic subtest: pipe-C
[324.475542] Dynamic subtest pipe-C: SUCCESS (1.429s)
[324.486603] Starting dynamic subtest: pipe-D
[325.901520] Dynamic subtest pipe-D: SUCCESS (1.425s)
[325.903697] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.568s)
[327.072038] [054/133] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[327.172413] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[327.176485] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[327.286477] [055/133] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[327.394872] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[327.399204] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[327.505653] [056/133] (693s left) gem_wait (wait)
[327.575747] Starting subtest: wait
[327.578250] Starting dynamic subtest: all-engines
[328.917210] Dynamic subtest all-engines: SUCCESS (1.339s)
[328.928575] Starting dynamic subtest: rcs0
[329.968262] Dynamic subtest rcs0: SUCCESS (1.048s)
[329.978890] Starting dynamic subtest: bcs0
[331.013511] Dynamic subtest bcs0: SUCCESS (1.046s)
[331.024329] Starting dynamic subtest: vcs0
[332.058531] Dynamic subtest vcs0: SUCCESS (1.043s)
[332.068438] Starting dynamic subtest: vcs1
[333.105406] Dynamic subtest vcs1: SUCCESS (1.045s)
[333.115790] Starting dynamic subtest: vecs0
[334.150321] Dynamic subtest vecs0: SUCCESS (1.043s)
[334.161190] Starting dynamic subtest: ccs0
[335.196724] Dynamic subtest ccs0: SUCCESS (1.044s)
[335.199544] Subtest wait: SUCCESS (7.621s)
[335.396922] [057/133] (685s left) perf (mi-rpc)
[335.537142] Starting subtest: mi-rpc
[335.541368] Subtest mi-rpc: SKIP (0.000s)
[335.576362] [058/133] (685s left) kms_flip (2x-flip-vs-dpms)
[335.667199] Starting subtest: 2x-flip-vs-dpms
[335.676884] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[335.781145] [059/133] (685s left) syncobj_basic (bad-create-flags)
[335.845615] Starting subtest: bad-create-flags
[335.847601] Subtest bad-create-flags: SUCCESS (0.000s)
[335.934566] [060/133] (685s left) api_intel_allocator (gem-pool)
[335.990756] Starting subtest: gem-pool
[335.996248] Subtest gem-pool: SUCCESS (0.006s)
[336.111327] [061/133] (685s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[336.203097] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[336.207107] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[336.274695] [062/133] (685s left) gem_exec_whisper (basic-sync)
[336.336331] Starting subtest: basic-sync
[343.143169] Subtest basic-sync: SUCCESS (6.807s)
[343.339417] [063/133] (678s left) perf_pmu (busy-start)
[343.393838] Starting subtest: busy-start
[343.396295] Starting dynamic subtest: rcs0
[345.954090] Dynamic subtest rcs0: SUCCESS (2.559s)
[345.965666] Starting dynamic subtest: bcs0
[348.501818] Dynamic subtest bcs0: SUCCESS (2.545s)
[348.513729] Starting dynamic subtest: vcs0
[351.893467] Dynamic subtest vcs0: SUCCESS (3.389s)
[351.905393] Starting dynamic subtest: vcs1
[355.925503] Dynamic subtest vcs1: SUCCESS (4.029s)
[355.937878] Starting dynamic subtest: vecs0
[359.893853] Dynamic subtest vecs0: SUCCESS (3.965s)
[359.905498] Starting dynamic subtest: ccs0
[362.443862] Dynamic subtest ccs0: SUCCESS (2.549s)
[362.446498] Subtest busy-start: SUCCESS (19.051s)
[362.558119] [064/133] (658s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[362.662829] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[362.665240] Starting dynamic subtest: pipe-A-eDP-1
[362.724061] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[362.734528] Starting dynamic subtest: pipe-B-eDP-1
[362.794580] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[362.804877] Starting dynamic subtest: pipe-C-eDP-1
[362.861952] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[362.871606] Starting dynamic subtest: pipe-D-eDP-1
[362.928951] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[362.933533] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[364.928381] [065/133] (656s left) kms_lease (lease-unleased-crtc)
[365.025189] Starting subtest: lease-unleased-crtc
[365.027511] Starting dynamic subtest: pipe-A-eDP-1
[365.323073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s)
[365.336923] Starting dynamic subtest: pipe-B-eDP-1
[366.086788] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s)
[366.097302] Starting dynamic subtest: pipe-C-eDP-1
[366.099602] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[366.107736] Starting dynamic subtest: pipe-D-eDP-1
[366.109676] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[366.111581] Subtest lease-unleased-crtc: SUCCESS (1.073s)
[366.452234] [066/133] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[366.555167] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[366.559146] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[366.656639] [067/133] (654s left) prime_vgem (basic-fence-read)
[366.826560] Starting subtest: basic-fence-read
[366.832048] Subtest basic-fence-read: SKIP (0.006s)
[366.933208] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[366.936982] [068/133] (654s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[367.045259] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[367.051751] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[367.149745] [069/133] (654s left) gem_exec_params (dr4-dirt)
[367.227085] Starting subtest: DR4-dirt
[367.229459] Subtest DR4-dirt: SUCCESS (0.000s)
[367.345259] [070/133] (654s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[367.447469] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[375.158095] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.712s)
[375.264660] [071/133] (646s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[375.361559] Starting subtest: fbc-modesetfrombusy
[379.235588] Subtest fbc-modesetfrombusy: SUCCESS (3.878s)
[380.412403] [072/133] (641s left) gem_create (create-ext-placement-sanity-check)
[380.586437] Starting subtest: create-ext-placement-sanity-check
[380.589154] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[380.711844] [073/133] (641s left) gem_partial_pwrite_pread (reads-uncached)
[380.765157] Subtest reads-uncached: SKIP (0.000s)
[380.835302] [074/133] (641s left) gem_reg_read (timestamp-monotonic)
[380.892764] Starting subtest: timestamp-monotonic
[385.503436] Subtest timestamp-monotonic: SUCCESS (4.610s)
[385.579381] [075/133] (636s left) kms_invalid_mode (int-max-clock)
[385.684893] Starting subtest: int-max-clock
[385.687044] Starting dynamic subtest: pipe-A-eDP-1
[385.968951] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[385.978347] Starting dynamic subtest: pipe-B-eDP-1
[385.980574] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[385.989062] Starting dynamic subtest: pipe-C-eDP-1
[385.991395] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[386.000054] Starting dynamic subtest: pipe-D-eDP-1
[386.002399] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[386.004696] Subtest int-max-clock: SUCCESS (0.292s)
[386.833457] [076/133] (635s left) gen7_exec_parse (oacontrol-tracking)
[386.910048] Subtest oacontrol-tracking: SKIP (0.000s)
[386.986020] [077/133] (635s left) gem_flink_basic (bad-flink)
[387.042036] Starting subtest: bad-flink
[387.044260] Subtest bad-flink: SUCCESS (0.000s)
[387.144136] [078/133] (634s left) kms_chamelium_edid (dp-edid-resolution-list)
[387.540719] Subtest dp-edid-resolution-list: SKIP (0.000s)
[388.346096] [079/133] (633s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[388.437753] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[388.440121] Starting dynamic subtest: pipe-A-eDP-1
[388.463844] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[388.474740] Starting dynamic subtest: pipe-B-eDP-1
[388.497590] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[388.506782] Starting dynamic subtest: pipe-C-eDP-1
[388.529127] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[388.537582] Starting dynamic subtest: pipe-D-eDP-1
[388.560050] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[388.564123] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[390.718151] [080/133] (631s left) gen3_render_linear_blits
[390.849453] [081/133] (631s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[390.902270] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[390.966623] [082/133] (631s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[391.092981] Starting subtest: 2x-long-flip-vs-cursor-legacy
[391.097570] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[391.244023] [083/133] (631s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[391.313690] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[391.318188] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[391.509482] [084/133] (630s left) kms_busy (extended-modeset-hang-oldfb)
[391.608080] Starting subtest: extended-modeset-hang-oldfb
[391.610446] Starting dynamic subtest: pipe-A
[403.415096] Dynamic subtest pipe-A: SUCCESS (11.805s)
[403.424994] Starting dynamic subtest: pipe-D
[415.674290] Dynamic subtest pipe-D: SUCCESS (12.257s)
[415.676599] Subtest extended-modeset-hang-oldfb: SUCCESS (24.067s)
[416.559133] [085/133] (605s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[416.651061] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[423.284258] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.636s)
[423.398417] [086/133] (598s left) perf_pmu (busy-check-all)
[423.448318] Starting subtest: busy-check-all
[423.450655] Starting dynamic subtest: rcs0
[424.000757] Dynamic subtest rcs0: SUCCESS (0.552s)
[424.013050] Starting dynamic subtest: bcs0
[424.550648] Dynamic subtest bcs0: SUCCESS (0.548s)
[424.562436] Starting dynamic subtest: vcs0
[425.943745] Dynamic subtest vcs0: SUCCESS (1.392s)
[425.956040] Starting dynamic subtest: vcs1
[427.926391] Dynamic subtest vcs1: SUCCESS (1.978s)
[427.938322] Starting dynamic subtest: vecs0
[429.910380] Dynamic subtest vecs0: SUCCESS (1.981s)
[429.922687] Starting dynamic subtest: ccs0
[430.466830] Dynamic subtest ccs0: SUCCESS (0.555s)
[430.469682] Subtest busy-check-all: SUCCESS (7.020s)
[430.566287] [087/133] (591s left) gem_exec_whisper (basic-fds-all)
[430.625634] Starting subtest: basic-fds-all
[443.894244] Subtest basic-fds-all: SUCCESS (13.267s)
[444.083331] [088/133] (578s left) kms_addfb_basic (unused-pitches)
[444.148693] Starting subtest: unused-pitches
[444.150981] Subtest unused-pitches: SUCCESS (0.000s)
[444.291575] [089/133] (578s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[444.399728] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[444.402046] Starting dynamic subtest: pipe-A-eDP-1
[444.424639] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[444.435402] Starting dynamic subtest: pipe-B-eDP-1
[444.456328] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[444.465375] Starting dynamic subtest: pipe-C-eDP-1
[444.486698] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[444.497236] Starting dynamic subtest: pipe-D-eDP-1
[444.518933] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[444.523132] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[446.644994] [090/133] (575s left) kms_psr (psr-primary-mmap-gtt)
[446.737159] Starting subtest: psr-primary-mmap-gtt
[446.739289] Starting dynamic subtest: eDP-1
[448.149053] Dynamic subtest eDP-1: SKIP (1.409s)
[448.154020] Subtest psr-primary-mmap-gtt: SKIP (1.411s)
[448.292837] [091/133] (574s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[448.394256] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[448.396540] Starting dynamic subtest: pipe-A-eDP-1
[448.405509] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[448.415157] Starting dynamic subtest: pipe-B-eDP-1
[448.426196] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[448.436755] Starting dynamic subtest: pipe-C-eDP-1
[448.445822] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[448.454417] Starting dynamic subtest: pipe-D-eDP-1
[448.462785] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[448.466811] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.014s)
[450.656305] [092/133] (571s left) kms_flip (2x-nonexisting-fb)
[450.750568] Starting subtest: 2x-nonexisting-fb
[450.762994] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[450.849429] [093/133] (571s left) fbdev (nullptr)
[450.895068] Starting subtest: nullptr
[450.897178] Subtest nullptr: SUCCESS (0.000s)
[450.954290] [094/133] (571s left) vgem_basic (unload)
[450.996910] Starting subtest: unload
[480.053424] Subtest unload: SUCCESS (29.059s)
[480.164797] [095/133] (542s left) gem_lmem_swapping (smem-oom)
[480.211042] Subtest smem-oom: SKIP (0.000s)
[480.248536] [096/133] (542s left) dmabuf_sync_file (export-wait-after-attach)
[480.296514] Starting subtest: export-wait-after-attach
[480.298598] Subtest export-wait-after-attach: SUCCESS (0.002s)
[480.351465] [097/133] (542s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[480.455276] Starting subtest: psr-2p-primscrn-cur-indfb-move
[480.459514] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[480.541836] [098/133] (542s left) perf (invalid-create-userspace-config)
[480.629061] Starting subtest: invalid-create-userspace-config
[480.631551] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[480.673200] [099/133] (542s left) gem_ctx_sseu (invalid-args)
[480.729600] Subtest invalid-args: SKIP (0.000s)
[480.797498] [100/133] (542s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[480.889475] Starting subtest: yf-tiled-8bpp-rotate-270
[480.893515] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[480.982523] [101/133] (542s left) syncobj_timeline (32bits-limit)
[481.036690] Starting subtest: 32bits-limit
[481.039065] Subtest 32bits-limit: SUCCESS (0.001s)
[481.125993] [102/133] (541s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[481.214156] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[481.217486] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[481.301652] [103/133] (541s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[481.358072] Starting subtest: etime-single-wait-all-for-submit-submitted
[481.465329] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[481.541496] [104/133] (541s left) gem_userptr_blits (unsync-unmap-cycles)
[481.604874] Subtest unsync-unmap-cycles: SKIP (0.000s)
[481.730357] [105/133] (541s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[481.783580] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[481.785573] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[481.883310] [106/133] (541s left) gem_mmap_gtt (big-bo-tiledx)
[481.945088] Subtest big-bo-tiledX: SKIP (0.000s)
[482.004977] [107/133] (541s left) sw_sync (sync_merge_invalid)
[482.042955] Starting subtest: sync_merge_invalid
[482.057390] Subtest sync_merge_invalid: SUCCESS (0.015s)
[482.127705] [108/133] (541s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[482.219017] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[482.223140] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[482.315606] [109/133] (541s left) i915_pm_rc6_residency (rc6-accuracy)
[482.369563] Starting subtest: rc6-accuracy
[482.371767] Starting dynamic subtest: gt0
[485.543465] Dynamic subtest gt0: SUCCESS (3.171s)
[485.554170] Starting dynamic subtest: gt1
[488.715937] Dynamic subtest gt1: SUCCESS (3.169s)
[488.718433] Subtest rc6-accuracy: SUCCESS (6.346s)
[488.812313] [110/133] (534s left) perf (polling)
[488.905223] Starting subtest: polling
[488.907462] Starting dynamic subtest: 0-rcs0
[498.918324] Dynamic subtest 0-rcs0: SUCCESS (10.011s)
[498.928484] Starting dynamic subtest: 1-vecs0
[508.938886] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[508.941419] Subtest polling: SUCCESS (20.032s)
[508.991445] [111/133] (514s left) kms_cursor_crc (cursor-alpha-transparent)
[509.079921] Starting subtest: cursor-alpha-transparent
[509.081929] Starting dynamic subtest: pipe-A-eDP-1
[509.704817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.625s)
[509.715322] Starting dynamic subtest: pipe-D-eDP-1
[511.084864] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.378s)
[511.087264] Subtest cursor-alpha-transparent: SUCCESS (2.007s)
[511.929075] [112/133] (511s left) gem_render_copy (linear-to-vebox-y-tiled)
[511.994129] Starting subtest: linear-to-vebox-y-tiled
[511.998578] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[512.187462] [113/133] (511s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[512.291778] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[512.296341] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[512.383915] [114/133] (511s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[512.545957] Starting subtest: cursor-rapid-movement-32x10
[512.594587] Subtest cursor-rapid-movement-32x10: SKIP (0.044s)
[512.869742] [115/133] (510s left) api_intel_bb (simple-bb)
[512.918314] Starting subtest: simple-bb
[512.921703] Subtest simple-bb: SUCCESS (0.006s)
[513.066654] [116/133] (510s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[513.166067] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[519.838968] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.673s)
[519.976535] [117/133] (503s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[520.102426] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[520.150074] [118/133] (503s left) gem_mmap_offset (oob-read)
[520.198083] Starting subtest: oob-read
[520.200177] Subtest oob-read: SUCCESS (0.000s)
[520.295421] [119/133] (503s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[520.394336] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[521.484284] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.499s)
[521.543224] [120/133] (502s left) prime_busy (hang-wait)
[521.601878] Starting subtest: hang-wait
[521.604289] Starting dynamic subtest: rcs0
[547.377181] Dynamic subtest rcs0: SUCCESS (25.771s)
[547.385989] Starting dynamic subtest: bcs0
[554.534809] Dynamic subtest bcs0: SUCCESS (7.154s)
[554.545374] Starting dynamic subtest: vcs0
[561.509709] Dynamic subtest vcs0: SUCCESS (6.972s)
[561.520722] Starting dynamic subtest: vcs1
[568.487837] Dynamic subtest vcs1: SUCCESS (6.975s)
[568.498774] Starting dynamic subtest: vecs0
[575.523845] Dynamic subtest vecs0: SUCCESS (7.035s)
[575.534835] Starting dynamic subtest: ccs0
[589.360614] Dynamic subtest ccs0: SUCCESS (13.836s)
[589.363205] Subtest hang-wait: SUCCESS (67.757s)
[589.487189] [121/133] (434s left) gem_tiled_fence_blits (basic)
[589.552464] Subtest basic: SKIP (0.000s)
[589.622781] [122/133] (434s left) gem_exec_fence (syncobj-timeline-export)
[590.178568] Starting subtest: syncobj-timeline-export
[590.188081] Subtest syncobj-timeline-export: SUCCESS (0.011s)
[591.979837] [123/133] (432s left) gem_fence_thrash (bo-write-verify-none)
[592.023688] Starting subtest: bo-write-verify-none
[592.033072] Subtest bo-write-verify-none: SKIP (0.014s)
[592.115360] [124/133] (431s left) gem_tiled_blits (normal)
[592.167801] Subtest normal: SKIP (0.000s)
[592.236119] [125/133] (431s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[592.334258] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[592.338475] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[592.438121] [126/133] (431s left) kms_chamelium_hpd (hdmi-hpd)
[592.828789] Subtest hdmi-hpd: SKIP (0.000s)
[593.661622] [127/133] (430s left) kms_vblank (query-forked-busy-hang)
[593.762062] Starting subtest: query-forked-busy-hang
[593.764296] Starting dynamic subtest: pipe-A-eDP-1
[620.694612] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.931s)
[620.709733] Starting dynamic subtest: pipe-D-eDP-1
[645.647808] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.948s)
[645.649865] Subtest query-forked-busy-hang: SUCCESS (51.884s)
[646.532420] [128/133] (377s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[646.600490] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[646.602774] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[646.701824] [129/133] (377s left) gem_mmap (pf-nonblock)
[646.758239] Subtest pf-nonblock: SKIP (0.000s)
[646.811683] [130/133] (377s left) kms_flip (blocking-absolute-wf_vblank)
[646.912053] Starting subtest: blocking-absolute-wf_vblank
[646.914507] Starting dynamic subtest: A-eDP1
[655.680027] Dynamic subtest A-eDP1: SUCCESS (8.767s)
[655.694533] Starting dynamic subtest: B-eDP1
[664.412809] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[664.424663] Starting dynamic subtest: C-eDP1
[673.130073] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[673.141343] Starting dynamic subtest: D-eDP1
[681.858437] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[681.863873] Subtest blocking-absolute-wf_vblank: SUCCESS (34.952s)
[683.067318] [131/133] (341s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[683.174563] Starting subtest: psr2-cursor-plane-update-sf
[683.176827] Starting dynamic subtest: pipe-A-eDP-1
[683.746227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.572s)
[683.756244] Starting dynamic subtest: pipe-B-eDP-1
[685.046354] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.301s)
[685.048761] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.876s)
[685.931084] [132/133] (338s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[686.029525] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[686.033897] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[686.122322] [133/133] (338s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[686.210154] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[686.212354] Starting dynamic subtest: pipe-A
[686.322513] Dynamic subtest pipe-A: SKIP (0.108s)
[686.331953] Starting dynamic subtest: pipe-B
[687.502059] Dynamic subtest pipe-B: SKIP (1.179s)
[687.514183] Starting dynamic subtest: pipe-C
[688.743452] Dynamic subtest pipe-C: SUCCESS (1.246s)
[688.752868] Starting dynamic subtest: pipe-D
[689.965272] Dynamic subtest pipe-D: SUCCESS (1.221s)
[689.967616] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.758s)
[691.164104] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: kms_cursor_edge_walk
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: gem_exec_parallel
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: gem_exec_gttfill
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_content_protection
results: parsing output: 11/ for test: i915_suspend
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_big
results: parsing output: 21/ for test: i915_drm_fdinfo
results: parsing output: 22/ for test: kms_async_flips
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_feature_discovery
results: parsing output: 28/ for test: kms_pm_rpm
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_color
results: parsing output: 32/ for test: kms_dsc
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: gem_ctx_param
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: kms_dirtyfb
results: parsing output: 39/ for test: sysfs_heartbeat_interval
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_async_flips
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: gem_ctx_param
results: parsing output: 46/ for test: kms_pipe_crc_basic
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: kms_addfb_basic
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: prime_mmap
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_wait
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: syncobj_basic
results: parsing output: 59/ for test: api_intel_allocator
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: prime_vgem
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_create
results: parsing output: 72/ for test: gem_partial_pwrite_pread
results: parsing output: 73/ for test: gem_reg_read
results: parsing output: 74/ for test: kms_invalid_mode
results: parsing output: 75/ for test: gen7_exec_parse
results: parsing output: 76/ for test: gem_flink_basic
results: parsing output: 77/ for test: kms_chamelium_edid
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gen3_render_linear_blits
results: parsing output: 80/ for test: kms_pipe_b_c_ivb
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: kms_busy
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: fbdev
results: parsing output: 93/ for test: vgem_basic
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: dmabuf_sync_file
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: gem_ctx_sseu
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: sw_sync
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: i915_pm_rc6_residency
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_cursor_crc
results: parsing output: 114/ for test: api_intel_bb
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_tiled_display
results: parsing output: 117/ for test: gem_mmap_offset
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: prime_busy
results: parsing output: 120/ for test: gem_tiled_fence_blits
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: gem_fence_thrash
results: parsing output: 123/ for test: gem_tiled_blits
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_mmap
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane_scaling
Done.