[57.854421] Initializing watchdogs
[57.854473]   /dev/watchdog0
[57.869019] [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]
[57.873551] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.875884] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.879204] [001/133] (960s left) gem_exec_reloc (basic-wc-read-noreloc)
[57.954494] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[58.032677] [002/133] (960s left) kms_flip (flip-vs-modeset-vs-hang)
[58.122342] Starting subtest: flip-vs-modeset-vs-hang
[58.124683] Starting dynamic subtest: A-eDP1
[110.386624] Dynamic subtest A-eDP1: SUCCESS (52.257s)
[110.402781] Starting dynamic subtest: D-eDP1
[160.372415] Dynamic subtest D-eDP1: SUCCESS (49.988s)
[160.374916] Subtest flip-vs-modeset-vs-hang: SUCCESS (102.251s)
[160.766455] [003/133] (857s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[160.861395] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[160.863782] Starting dynamic subtest: pipe-A-eDP-1
[160.873416] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[160.882692] Starting dynamic subtest: pipe-B-eDP-1
[160.892061] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[160.899196] Starting dynamic subtest: pipe-C-eDP-1
[160.907696] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[160.914099] Starting dynamic subtest: pipe-D-eDP-1
[160.922644] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[160.926860] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s)
[163.126047] [004/133] (855s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[163.247239] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[163.871145] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.626s)
[164.060604] [005/133] (854s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[164.165379] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[164.169913] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[164.290960] [006/133] (854s left) gem_mmap_wc (write)
[164.355757] Subtest write: SKIP (0.000s)
[164.422969] [007/133] (854s left) gem_exec_whisper (basic-forked)
[164.489826] Starting subtest: basic-forked
[170.931047] Subtest basic-forked: SUCCESS (6.439s)
[171.124816] [008/133] (847s left) i915_drm_fdinfo (memory-info-resident)
[171.171401] Starting subtest: memory-info-resident
[171.173847] Starting dynamic subtest: smem0
[174.028308] Dynamic subtest smem0: SUCCESS (2.859s)
[174.030522] Subtest memory-info-resident: SUCCESS (2.859s)
[174.113052] [009/133] (844s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[174.207428] Starting subtest: fbcpsr-rgb101010-draw-blt
[181.006171] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.801s)
[181.143721] [010/133] (837s left) syncobj_wait (invalid-wait-bad-flags)
[181.209511] Starting subtest: invalid-wait-bad-flags
[181.211528] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[181.325605] [011/133] (837s left) kms_flip (2x-dpms-vs-vblank-race)
[181.417353] Starting subtest: 2x-dpms-vs-vblank-race
[181.426504] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[181.552261] [012/133] (837s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[181.656018] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[189.225060] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.574s)
[189.382710] [013/133] (829s left) gem_ctx_param (invalid-set-no-zeromap)
[189.446657] Starting subtest: invalid-set-no-zeromap
[189.449090] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[189.531067] [014/133] (829s left) gem_lmem_swapping (parallel-random)
[189.567061] Subtest parallel-random: SKIP (0.000s)
[189.603725] [015/133] (829s left) kms_scaling_modes (scaling-mode-none)
[189.697117] Starting subtest: scaling-mode-none
[189.699487] Starting dynamic subtest: pipe-A-eDP-1
[189.792976] Dynamic subtest pipe-A-eDP-1: SKIP (0.095s)
[189.802236] Starting dynamic subtest: pipe-B-eDP-1
[189.826793] Dynamic subtest pipe-B-eDP-1: SKIP (0.032s)
[189.834935] Starting dynamic subtest: pipe-C-eDP-1
[189.859306] Dynamic subtest pipe-C-eDP-1: SKIP (0.031s)
[189.867821] Starting dynamic subtest: pipe-D-eDP-1
[189.892525] Dynamic subtest pipe-D-eDP-1: SKIP (0.033s)
[189.896751] Subtest scaling-mode-none: SKIP (0.196s)
[190.027925] [016/133] (828s left) kms_flip (busy-flip)
[190.119987] Starting subtest: busy-flip
[190.122285] Starting dynamic subtest: A-eDP1
[191.778423] Dynamic subtest A-eDP1: SUCCESS (1.660s)
[191.786372] Starting dynamic subtest: B-eDP1
[193.510810] Dynamic subtest B-eDP1: SUCCESS (1.731s)
[193.518898] Starting dynamic subtest: C-eDP1
[195.150925] Dynamic subtest C-eDP1: SUCCESS (1.640s)
[195.162195] Starting dynamic subtest: D-eDP1
[196.799786] Dynamic subtest D-eDP1: SUCCESS (1.634s)
[196.801913] Subtest busy-flip: SUCCESS (6.671s)
[197.964668] [017/133] (821s left) gem_spin_batch (legacy-resubmit-new)
[198.044604] Starting subtest: legacy-resubmit-new
[198.047021] Starting dynamic subtest: default
[198.052305] Dynamic subtest default: SUCCESS (0.007s)
[198.062199] Starting dynamic subtest: render
[198.064420] Dynamic subtest render: SUCCESS (0.003s)
[198.072080] Starting dynamic subtest: bsd
[198.074433] Dynamic subtest bsd: SUCCESS (0.006s)
[198.082173] Starting dynamic subtest: bsd1
[198.084373] Dynamic subtest bsd1: SUCCESS (0.004s)
[198.091753] Starting dynamic subtest: bsd2
[198.093970] Dynamic subtest bsd2: SUCCESS (0.004s)
[198.101415] Starting dynamic subtest: blt
[198.103653] Dynamic subtest blt: SUCCESS (0.004s)
[198.111129] Starting dynamic subtest: vebox
[198.113293] Dynamic subtest vebox: SUCCESS (0.004s)
[198.115456] Subtest legacy-resubmit-new: SUCCESS (0.036s)
[199.954839] [018/133] (819s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[200.066884] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[200.071410] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[200.186222] [019/133] (818s left) syncobj_wait (single-wait-all-for-submit-submitted)
[200.252920] Starting subtest: single-wait-all-for-submit-submitted
[200.361682] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[200.466232] [020/133] (818s left) i915_pm_rc6_residency (rc6-accuracy)
[200.528405] Starting subtest: rc6-accuracy
[200.530774] Starting dynamic subtest: gt0
[203.700373] Dynamic subtest gt0: SUCCESS (3.169s)
[203.710823] Starting dynamic subtest: gt1
[206.871296] Dynamic subtest gt1: SUCCESS (3.169s)
[206.873686] Subtest rc6-accuracy: SUCCESS (6.342s)
[206.954363] [021/133] (812s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[207.075056] Starting subtest: 4-tiled-16bpp-rotate-270
[207.096819] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.021s)
[207.247098] [022/133] (811s left) fbdev (write)
[207.283987] Starting subtest: write
[207.703700] Subtest write: SUCCESS (0.418s)
[207.775770] [023/133] (811s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[207.983413] Starting subtest: cursor-rapid-movement-128x128
[207.988361] Starting dynamic subtest: pipe-A-eDP-1
[208.529963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[208.554825] Starting dynamic subtest: pipe-D-eDP-1
[209.758284] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.208s)
[209.760707] Subtest cursor-rapid-movement-128x128: SUCCESS (1.773s)
[210.631847] [024/133] (808s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[210.733322] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[218.113145] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.382s)
[218.237898] [025/133] (801s left) kms_sequence (get-forked)
[218.334060] Starting subtest: get-forked
[218.336432] Starting dynamic subtest: pipe-A-eDP-1
[220.239579] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.905s)
[220.248823] Starting dynamic subtest: pipe-B-eDP-1
[222.805647] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.567s)
[222.814155] Starting dynamic subtest: pipe-C-eDP-1
[225.372832] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.564s)
[225.382604] Starting dynamic subtest: pipe-D-eDP-1
[227.869446] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.495s)
[227.871710] Subtest get-forked: SUCCESS (9.536s)
[228.737794] [026/133] (790s left) core_auth (getclient-simple)
[228.781305] Starting subtest: getclient-simple
[228.804369] Subtest getclient-simple: SUCCESS (0.023s)
[228.930874] [027/133] (790s left) gem_vm_create (isolation)
[229.000062] Starting subtest: isolation
[229.009690] Subtest isolation: SUCCESS (0.009s)
[229.138571] [028/133] (790s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[229.261379] Starting subtest: verify-pxp-key-change-after-suspend-resume
[236.551217] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.292s)
[245.709215] [029/133] (782s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[245.823522] Starting subtest: fbc-pr-cursor-plane-update-sf
[245.827729] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[245.907305] [030/133] (782s left) gem_userptr_blits (sync-overlap)
[245.973087] Starting subtest: sync-overlap
[245.975072] Subtest sync-overlap: SUCCESS (0.000s)
[246.105479] [031/133] (782s left) kms_big_fb (linear-32bpp-rotate-90)
[246.208775] Starting subtest: linear-32bpp-rotate-90
[246.230203] Subtest linear-32bpp-rotate-90: SKIP (0.018s)
[246.393974] [032/133] (782s left) kms_dp_link_training (uhbr-sst)
[246.504292] Starting subtest: uhbr-sst
[246.512803] Subtest uhbr-sst: SKIP (0.000s)
[246.600017] [033/133] (782s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[246.700117] Starting subtest: fbc-pr-cursor-mmap-gtt
[246.704276] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[246.781551] [034/133] (781s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[246.889928] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[246.891860] Starting dynamic subtest: pipe-A-eDP-1
[246.985951] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[246.995899] Starting dynamic subtest: pipe-B-eDP-1
[248.109817] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[248.114322] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.223s)
[249.307497] [035/133] (779s left) gem_exec_fence (syncobj-repeat)
[249.778734] Starting subtest: syncobj-repeat
[249.956691] Subtest syncobj-repeat: SUCCESS (0.176s)
[251.032889] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[251.036207] [036/133] (777s left) syncobj_timeline (transfer-timeline-point)
[251.093372] Starting subtest: transfer-timeline-point
[251.095582] Subtest transfer-timeline-point: SUCCESS (0.000s)
[251.221482] [037/133] (777s left) kms_addfb_basic (bad-pitch-0)
[251.290741] Starting subtest: bad-pitch-0
[251.293055] Subtest bad-pitch-0: SUCCESS (0.000s)
[251.456243] [038/133] (777s left) dmabuf_sync_file (import-multiple-read-write)
[251.497046] Starting subtest: import-multiple-read-write
[251.499224] Subtest import-multiple-read-write: SUCCESS (0.003s)
[251.565299] [039/133] (777s left) kms_plane (plane-position-covered)
[251.672111] Starting subtest: plane-position-covered
[252.206687] Starting dynamic subtest: pipe-A-plane-1
[253.491604] Dynamic subtest pipe-A-plane-1: SUCCESS (1.284s)
[253.500231] Starting dynamic subtest: pipe-A-plane-2
[254.789071] Dynamic subtest pipe-A-plane-2: SUCCESS (1.298s)
[254.799033] Starting dynamic subtest: pipe-A-plane-3
[256.050776] Dynamic subtest pipe-A-plane-3: SUCCESS (1.260s)
[256.060513] Starting dynamic subtest: pipe-A-plane-4
[257.377272] Dynamic subtest pipe-A-plane-4: SUCCESS (1.328s)
[257.388132] Starting dynamic subtest: pipe-A-plane-5
[257.402709] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[258.618265] Starting dynamic subtest: pipe-B-plane-1
[259.938484] Dynamic subtest pipe-B-plane-1: SUCCESS (1.326s)
[259.951848] Starting dynamic subtest: pipe-B-plane-2
[261.169863] Dynamic subtest pipe-B-plane-2: SUCCESS (1.233s)
[261.179358] Starting dynamic subtest: pipe-B-plane-3
[262.433112] Dynamic subtest pipe-B-plane-3: SUCCESS (1.262s)
[262.442041] Starting dynamic subtest: pipe-B-plane-4
[263.720816] Dynamic subtest pipe-B-plane-4: SUCCESS (1.289s)
[263.731048] Starting dynamic subtest: pipe-B-plane-5
[263.746193] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[263.748573] Subtest plane-position-covered: SUCCESS (12.076s)
[264.554688] [040/133] (764s left) kms_addfb_basic (invalid-get-prop)
[264.619164] Starting subtest: invalid-get-prop
[264.621224] Subtest invalid-get-prop: SUCCESS (0.000s)
[264.785252] [041/133] (764s left) kms_plane_alpha_blend (coverage-7efc)
[264.888060] Starting subtest: coverage-7efc
[265.179906] Starting dynamic subtest: pipe-A-eDP-1
[265.745201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[265.772322] Starting dynamic subtest: pipe-D-eDP-1
[267.044798] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.278s)
[267.047085] Subtest coverage-7efc: SUCCESS (2.157s)
[267.894468] [042/133] (761s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[268.001423] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[268.005734] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[268.146196] [043/133] (760s left) kms_flip (flip-vs-expired-vblank)
[268.252606] Starting subtest: flip-vs-expired-vblank
[268.254835] Starting dynamic subtest: A-eDP1
[276.891177] Dynamic subtest A-eDP1: SUCCESS (8.640s)
[276.902140] Starting dynamic subtest: B-eDP1
[285.520122] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[285.531684] Starting dynamic subtest: C-eDP1
[294.150203] Dynamic subtest C-eDP1: SUCCESS (8.628s)
[294.161594] Starting dynamic subtest: D-eDP1
[302.783436] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[302.785811] Subtest flip-vs-expired-vblank: SUCCESS (34.537s)
[303.973976] [044/133] (725s left) perf_pmu (pmu-read)
[304.013276] Starting subtest: pmu-read
[304.015750] Subtest pmu-read: SUCCESS (0.003s)
[304.140901] [045/133] (725s left) kms_lease (master-vs-lease)
[304.241933] Starting subtest: master-vs-lease
[304.244236] Subtest master-vs-lease: SUCCESS (0.001s)
[304.369151] [046/133] (724s left) kms_prime (basic-modeset-hybrid)
[304.456491] Subtest basic-modeset-hybrid: SKIP (0.000s)
[304.575088] [047/133] (724s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[304.694319] Starting subtest: cursor-vs-flip-toggle
[335.510548] Subtest cursor-vs-flip-toggle: SUCCESS (30.814s)
[336.406339] [048/133] (692s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[336.463436] Starting subtest: multi-wait-all-for-submit-signaled
[336.465580] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[336.568931] [049/133] (692s left) kms_atomic_interruptible (legacy-pageflip)
[336.655263] Starting subtest: legacy-pageflip
[336.657497] Starting dynamic subtest: pipe-A-eDP-1
[344.101095] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.446s)
[344.103453] Subtest legacy-pageflip: SUCCESS (7.448s)
[344.959177] [050/133] (684s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[345.059467] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[345.061778] Starting dynamic subtest: pipe-A-eDP-1
[345.120987] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[345.129872] Starting dynamic subtest: pipe-B-eDP-1
[345.187643] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[345.197761] Starting dynamic subtest: pipe-C-eDP-1
[345.253982] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[345.263875] Starting dynamic subtest: pipe-D-eDP-1
[345.319770] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[345.323740] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[347.316431] [051/133] (682s left) kms_flip (2x-plain-flip-interruptible)
[347.440090] Starting subtest: 2x-plain-flip-interruptible
[347.454395] Subtest 2x-plain-flip-interruptible: SKIP (0.013s)
[347.557026] [052/133] (681s left) kms_psr (psr2-cursor-mmap-cpu)
[347.647413] Starting subtest: psr2-cursor-mmap-cpu
[347.649716] Starting dynamic subtest: eDP-1
[349.389320] Dynamic subtest eDP-1: SUCCESS (1.741s)
[349.391770] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.742s)
[350.195731] [053/133] (679s left) gem_fence_thrash (bo-write-verify-y)
[350.232381] Starting subtest: bo-write-verify-y
[350.261357] Subtest bo-write-verify-y: SKIP (0.026s)
[350.330901] [054/133] (679s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[350.427399] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[350.431559] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[350.565340] [055/133] (679s left) gem_exec_balancer (bonded-pair)
[350.644951] Starting subtest: bonded-pair
[350.649455] Subtest bonded-pair: SKIP (0.000s)
[350.990419] [056/133] (678s left) kms_invalid_mode (clock-too-high)
[351.082953] Starting subtest: clock-too-high
[351.085228] Starting dynamic subtest: pipe-A-eDP-1
[351.089256] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[351.099107] Starting dynamic subtest: pipe-B-eDP-1
[351.103397] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[351.112024] Starting dynamic subtest: pipe-C-eDP-1
[351.116036] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[351.124095] Starting dynamic subtest: pipe-D-eDP-1
[351.128136] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[351.132152] Subtest clock-too-high: SKIP (0.005s)
[351.168629] [057/133] (678s left) kms_cdclk (mode-transition)
[351.271240] Starting subtest: mode-transition
[351.273443] Starting dynamic subtest: pipe-A-eDP-1
[351.564694] Dynamic subtest pipe-A-eDP-1: SKIP (0.291s)
[351.578027] Starting dynamic subtest: pipe-B-eDP-1
[351.582777] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[351.593741] Starting dynamic subtest: pipe-C-eDP-1
[351.598247] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[351.606605] Starting dynamic subtest: pipe-D-eDP-1
[351.610937] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[351.615675] Subtest mode-transition: SKIP (0.299s)
[352.424214] [058/133] (677s left) gen9_exec_parse (batch-zero-length)
[352.494612] Subtest batch-zero-length: SKIP (0.000s)
[352.581961] [059/133] (677s left) kms_flip (plain-flip-ts-check)
[352.685065] Starting subtest: plain-flip-ts-check
[352.687305] Starting dynamic subtest: A-eDP1
[361.594771] Dynamic subtest A-eDP1: SUCCESS (8.908s)
[361.608689] Starting dynamic subtest: B-eDP1
[370.427784] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[370.441819] Starting dynamic subtest: C-eDP1
[379.251101] Dynamic subtest C-eDP1: SUCCESS (8.821s)
[379.259949] Starting dynamic subtest: D-eDP1
[388.083630] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[388.089838] Subtest plain-flip-ts-check: SUCCESS (35.403s)
[389.281863] [060/133] (640s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[389.390664] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[389.394999] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[389.527563] [061/133] (640s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[389.603314] Starting subtest: invalid-bsd1-flag-on-blt
[389.605613] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[389.746298] [062/133] (640s left) perf (gen8-unprivileged-single-ctx-counters)
[389.876322] Starting subtest: gen8-unprivileged-single-ctx-counters
[389.879917] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[389.918992] [063/133] (639s left) kms_vrr (lobf)
[390.017119] Starting subtest: lobf
[390.021107] Subtest lobf: SKIP (0.000s)
[390.105692] [064/133] (639s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[390.207085] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[390.210473] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[390.344938] [065/133] (639s left) kms_psr (psr-cursor-blt)
[390.441615] Starting subtest: psr-cursor-blt
[390.443660] Starting dynamic subtest: eDP-1
[392.155596] Dynamic subtest eDP-1: SUCCESS (1.712s)
[392.157947] Subtest psr-cursor-blt: SUCCESS (1.713s)
[393.028592] [066/133] (637s left) syncobj_timeline (etime-multi-wait-all-submitted)
[393.078269] Starting subtest: etime-multi-wait-all-submitted
[393.185747] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s)
[393.277079] [067/133] (636s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[393.389662] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[393.391919] Starting dynamic subtest: pipe-A-eDP-1
[393.413860] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[393.423650] Starting dynamic subtest: pipe-B-eDP-1
[393.444699] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[393.453425] Starting dynamic subtest: pipe-C-eDP-1
[393.473928] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[393.482254] Starting dynamic subtest: pipe-D-eDP-1
[393.503096] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[393.506974] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[395.674888] [068/133] (634s left) i915_getparams_basic (basic-eu-total)
[395.746247] Starting subtest: basic-eu-total
[395.750594] Subtest basic-eu-total: SUCCESS (0.000s)
[395.860096] [069/133] (634s left) kms_cursor_edge_walk (128x128-top-edge)
[395.952719] Starting subtest: 128x128-top-edge
[395.954909] Starting dynamic subtest: pipe-A-eDP-1
[399.414976] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.463s)
[399.424540] Starting dynamic subtest: pipe-D-eDP-1
[402.552182] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[402.554498] Subtest 128x128-top-edge: SUCCESS (6.600s)
[403.399820] [070/133] (626s left) gen3_render_linear_blits
[403.532907] [071/133] (626s left) kms_flip (flip-vs-wf_vblank-interruptible)
[403.626019] Starting subtest: flip-vs-wf_vblank-interruptible
[403.628308] Starting dynamic subtest: A-eDP1
[405.520497] Dynamic subtest A-eDP1: SUCCESS (1.893s)
[405.530670] Starting dynamic subtest: B-eDP1
[407.451774] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[407.463072] Starting dynamic subtest: C-eDP1
[409.367107] Dynamic subtest C-eDP1: SUCCESS (1.914s)
[409.375964] Starting dynamic subtest: D-eDP1
[411.297206] Dynamic subtest D-eDP1: SUCCESS (1.929s)
[411.302213] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.675s)
[412.552424] [072/133] (617s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[412.663071] Starting subtest: fbc-shrfb-scaledprimary
[415.600620] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.940s)
[416.786921] [073/133] (613s left) kms_vblank (query-idle-hang)
[416.873335] Starting subtest: query-idle-hang
[416.875540] Starting dynamic subtest: pipe-A-eDP-1
[443.732174] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.857s)
[443.747138] Starting dynamic subtest: pipe-D-eDP-1
[458.708399] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.972s)
[458.710751] Subtest query-idle-hang: SUCCESS (41.834s)
[459.594277] [074/133] (570s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[459.707407] Starting subtest: y-tiled-64bpp-rotate-0
[459.711452] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[459.830218] [075/133] (570s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[459.893046] Starting subtest: multi-wait-all-available-submitted-signaled
[459.895339] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[460.019478] [076/133] (570s left) syncobj_basic (bad-flags-handle-to-fd)
[460.067998] Starting subtest: bad-flags-handle-to-fd
[460.070187] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[460.188143] [077/133] (570s left) gem_pread (self)
[460.247800] Subtest self: SKIP (0.000s)
[460.317451] [078/133] (570s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[460.447166] Starting subtest: basic-flip-after-cursor-legacy
[461.359345] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.911s)
[462.224327] [079/133] (568s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[462.323071] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[462.325254] Starting dynamic subtest: pipe-A-default-mode
[465.029462] Dynamic subtest pipe-A-default-mode: SUCCESS (2.705s)
[465.031836] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.707s)
[465.902966] [080/133] (564s left) syncobj_basic (bad-destroy-pad)
[465.972501] Starting subtest: bad-destroy-pad
[465.974465] Subtest bad-destroy-pad: SUCCESS (0.000s)
[466.077261] [081/133] (564s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[466.163555] Starting subtest: psr-dirtyfb-ioctl
[466.165832] Starting dynamic subtest: A-eDP-1
[470.082794] Dynamic subtest A-eDP-1: SUCCESS (3.921s)
[470.085344] Subtest psr-dirtyfb-ioctl: SUCCESS (3.922s)
[470.901818] [082/133] (559s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[471.011133] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[474.992209] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.983s)
[476.210488] [083/133] (554s left) sysfs_preempt_timeout (idempotent)
[476.276622] Starting subtest: idempotent
[476.279105] Starting dynamic subtest: vecs0
[476.281408] Dynamic subtest vecs0: SUCCESS (0.000s)
[476.292064] Starting dynamic subtest: ccs0
[476.294215] Dynamic subtest ccs0: SUCCESS (0.000s)
[476.302896] Starting dynamic subtest: vcs0
[476.305088] Dynamic subtest vcs0: SUCCESS (0.000s)
[476.313738] Starting dynamic subtest: bcs0
[476.315988] Dynamic subtest bcs0: SUCCESS (0.000s)
[476.324879] Starting dynamic subtest: rcs0
[476.326816] Dynamic subtest rcs0: SUCCESS (0.000s)
[476.334843] Starting dynamic subtest: vcs1
[476.337148] Dynamic subtest vcs1: SUCCESS (0.000s)
[476.339281] Subtest idempotent: SUCCESS (0.006s)
[476.394033] [084/133] (554s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[476.488276] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[476.492445] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[476.607842] [085/133] (554s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[476.713248] Starting subtest: fbc-psr2-sprite-mmap-cpu
[476.715442] Starting dynamic subtest: eDP-1
[476.719766] Dynamic subtest eDP-1: SKIP (0.000s)
[476.723825] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[476.810271] [086/133] (554s left) prime_self_import (export-vs-gem_close-race)
[476.854917] Starting subtest: export-vs-gem_close-race
[481.969073] Subtest export-vs-gem_close-race: SUCCESS (5.118s)
[482.071955] [087/133] (548s left) kms_content_protection (srm)
[482.223982] Starting subtest: srm
[482.231329] Subtest srm: SKIP (0.003s)
[482.398806] [088/133] (548s left) gem_exec_async (concurrent-writes)
[482.467037] Starting subtest: concurrent-writes
[482.468959] Starting dynamic subtest: rcs0
[482.483539] Dynamic subtest rcs0: SUCCESS (0.019s)
[482.495687] Starting dynamic subtest: bcs0
[482.498596] Dynamic subtest bcs0: SUCCESS (0.009s)
[482.518831] Starting dynamic subtest: vcs0
[482.520749] Dynamic subtest vcs0: SUCCESS (0.006s)
[482.530147] Starting dynamic subtest: vcs1
[482.532212] Dynamic subtest vcs1: SUCCESS (0.007s)
[482.540982] Starting dynamic subtest: vecs0
[482.543111] Dynamic subtest vecs0: SUCCESS (0.006s)
[482.551700] Starting dynamic subtest: ccs0
[482.553753] Dynamic subtest ccs0: SUCCESS (0.006s)
[482.555804] Subtest concurrent-writes: SUCCESS (0.057s)
[482.803369] [089/133] (548s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[483.201720] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[483.989737] [090/133] (547s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[484.081861] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[484.084681] Starting dynamic subtest: pipe-A-eDP-1
[484.507688] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.428s)
[484.518903] Starting dynamic subtest: pipe-B-eDP-1
[484.538607] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[484.547933] Starting dynamic subtest: pipe-C-eDP-1
[484.566416] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[484.574794] Starting dynamic subtest: pipe-D-eDP-1
[484.593672] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[484.595576] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.442s)
[486.801931] [091/133] (544s left) gem_create (create-size-update)
[486.862367] Starting subtest: create-size-update
[486.864616] Subtest create-size-update: SUCCESS (0.000s)
[487.082330] [092/133] (544s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[487.168718] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[487.170706] Starting dynamic subtest: A-eDP1
[490.819283] Dynamic subtest A-eDP1: SUCCESS (3.652s)
[490.828691] Starting dynamic subtest: B-eDP1
[494.038385] Dynamic subtest B-eDP1: SUCCESS (3.215s)
[494.048617] Starting dynamic subtest: C-eDP1
[497.174537] Dynamic subtest C-eDP1: SUCCESS (3.137s)
[497.189720] Starting dynamic subtest: D-eDP1
[500.377244] Dynamic subtest D-eDP1: SUCCESS (3.203s)
[500.379577] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.214s)
[501.190933] [093/133] (530s left) kms_cursor_crc (cursor-alpha-transparent)
[501.275077] Starting subtest: cursor-alpha-transparent
[501.277391] Starting dynamic subtest: pipe-A-eDP-1
[501.882024] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[501.896212] Starting dynamic subtest: pipe-D-eDP-1
[503.156710] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.272s)
[503.158900] Subtest cursor-alpha-transparent: SUCCESS (1.883s)
[503.969891] [094/133] (527s left) kms_plane_multiple (tiling-yf)
[504.064238] Starting subtest: tiling-yf
[504.068552] Subtest tiling-yf: SKIP (0.000s)
[504.150783] [095/133] (527s left) i915_query (query-topology-garbage-items)
[504.219668] Starting subtest: query-topology-garbage-items
[504.221966] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[504.342592] [096/133] (527s left) gem_mmap_gtt (bad-object)
[504.408635] Subtest bad-object: SKIP (0.000s)
[504.477692] [097/133] (526s left) gem_exec_schedule (preempt-queue-contexts-chain)
[504.556750] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[504.853424] [098/133] (526s left) gem_exec_reloc (basic-write-read-noreloc)
[504.917613] Subtest basic-write-read-noreloc: SKIP (0.000s)
[505.004322] [099/133] (526s left) kms_atomic (plane-primary-legacy)
[505.098879] Starting subtest: plane-primary-legacy
[505.101060] Starting dynamic subtest: pipe-A-eDP-1
[505.548569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[505.550749] Subtest plane-primary-legacy: SUCCESS (0.450s)
[506.399572] [100/133] (525s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[506.507894] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[513.821330] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.316s)
[513.997994] [101/133] (517s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[514.091949] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[514.096390] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[514.207333] [102/133] (517s left) prime_vgem (basic-fence-flip)
[514.297877] Starting subtest: basic-fence-flip
[514.599216] Subtest basic-fence-flip: SUCCESS (0.301s)
[514.731297] [103/133] (516s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[514.827175] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[514.839100] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[514.914077] [104/133] (516s left) gem_ctx_persistence (userptr)
[514.973523] Starting subtest: userptr
[515.151506] Subtest userptr: SUCCESS (0.181s)
[515.246237] [105/133] (516s left) sw_sync (sync_busy_fork_unixsocket)
[515.281932] Starting subtest: sync_busy_fork_unixsocket
[515.287207] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[515.375557] [106/133] (516s left) gem_userptr_blits (sync-unmap-cycles)
[515.447715] Starting subtest: sync-unmap-cycles
[520.815087] Subtest sync-unmap-cycles: SUCCESS (5.369s)
[521.015068] [107/133] (510s left) gem_mmap_gtt (zero-extend)
[521.085435] Subtest zero-extend: SKIP (0.000s)
[521.152494] [108/133] (510s left) kms_properties (plane-properties-atomic)
[521.255091] Starting subtest: plane-properties-atomic
[521.256809] Starting dynamic subtest: pipe-A-eDP-1
[521.804107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[521.814147] Starting dynamic subtest: pipe-B-eDP-1
[523.065877] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.260s)
[523.075505] Starting dynamic subtest: pipe-C-eDP-1
[524.300964] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.235s)
[524.310216] Starting dynamic subtest: pipe-D-eDP-1
[525.532624] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[525.534914] Subtest plane-properties-atomic: SUCCESS (4.276s)
[526.355223] [109/133] (505s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[526.469441] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[526.473529] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[526.598159] [110/133] (505s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[526.693613] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[527.085149] Starting dynamic subtest: pipe-A-eDP-1
[529.823203] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.737s)
[530.208829] Starting dynamic subtest: pipe-B-eDP-1
[532.953077] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.752s)
[533.312320] Starting dynamic subtest: pipe-C-eDP-1
[536.082951] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.777s)
[536.455330] Starting dynamic subtest: pipe-D-eDP-1
[539.214153] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[539.216844] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.522s)
[540.450497] [111/133] (491s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[540.570446] Starting subtest: pipe-fbc-rte
[540.577575] Starting dynamic subtest: pipe-B-eDP-1
[546.102032] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.535s)
[546.109234] Subtest pipe-fbc-rte: SUCCESS (5.537s)
[548.469236] [112/133] (483s left) api_intel_allocator (execbuf-with-allocator)
[548.530636] Starting subtest: execbuf-with-allocator
[548.533258] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[548.685494] [113/133] (483s left) gem_exec_reloc (basic-gtt-noreloc)
[548.742739] Subtest basic-gtt-noreloc: SKIP (0.000s)
[548.822864] [114/133] (483s left) gem_exec_params (invalid-batch-start-offset)
[548.886627] Starting subtest: invalid-batch-start-offset
[548.891950] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[549.020742] [115/133] (483s left) kms_color (legacy-gamma-reset)
[549.106771] Starting subtest: legacy-gamma-reset
[549.108676] Starting dynamic subtest: pipe-A-eDP-1
[549.483764] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.379s)
[549.492960] Starting dynamic subtest: pipe-B-eDP-1
[549.497909] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[549.506805] Starting dynamic subtest: pipe-C-eDP-1
[549.511707] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[549.520564] Starting dynamic subtest: pipe-D-eDP-1
[549.522494] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[549.524838] Subtest legacy-gamma-reset: SUCCESS (0.418s)
[550.281833] [116/133] (481s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[550.346483] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[550.350666] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[550.555219] [117/133] (481s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[550.654091] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[550.658244] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[550.745525] [118/133] (481s left) prime_busy (hang-wait)
[550.811677] Starting subtest: hang-wait
[550.813856] Starting dynamic subtest: rcs0
[577.394571] Dynamic subtest rcs0: SUCCESS (26.580s)
[577.403217] Starting dynamic subtest: bcs0
[584.549072] Dynamic subtest bcs0: SUCCESS (7.153s)
[584.557742] Starting dynamic subtest: vcs0
[591.588856] Dynamic subtest vcs0: SUCCESS (7.038s)
[591.597581] Starting dynamic subtest: vcs1
[598.500042] Dynamic subtest vcs1: SUCCESS (6.905s)
[598.508521] Starting dynamic subtest: vecs0
[605.543342] Dynamic subtest vecs0: SUCCESS (7.041s)
[605.553856] Starting dynamic subtest: ccs0
[619.377996] Dynamic subtest ccs0: SUCCESS (13.834s)
[619.380471] Subtest hang-wait: SUCCESS (68.565s)
[619.544996] [119/133] (412s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[621.079426] Starting subtest: dpms-mode-unset-lpsp
[625.148219] Subtest dpms-mode-unset-lpsp: SUCCESS (4.072s)
[625.543721] [120/133] (406s left) gem_exec_balancer (waits)
[625.617487] Starting subtest: waits
[632.100999] Subtest waits: SUCCESS (6.485s)
[632.420292] [121/133] (400s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[632.530055] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[636.995305] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.468s)
[638.137593] [122/133] (394s left) syncobj_eventfd (timeline-wait-signaled)
[638.212293] Starting subtest: timeline-wait-signaled
[638.214166] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[638.334982] [123/133] (394s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[638.425531] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[638.429874] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[638.545278] [124/133] (394s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[638.608479] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[638.665533] [125/133] (394s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[638.770556] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[638.774798] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[638.890322] [126/133] (393s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[639.277451] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[640.122472] [127/133] (392s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[640.187026] Starting subtest: invalid-bsd2-flag-on-blt
[640.188917] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[640.307030] [128/133] (392s left) gem_exec_schedule (in-order)
[640.389246] Starting subtest: in-order
[640.391138] Starting dynamic subtest: rcs0
[640.480987] Dynamic subtest rcs0: SUCCESS (0.098s)
[640.493091] Starting dynamic subtest: vcs0
[640.566763] Dynamic subtest vcs0: SUCCESS (0.085s)
[640.578375] Starting dynamic subtest: vcs1
[640.658784] Dynamic subtest vcs1: SUCCESS (0.091s)
[640.671855] Starting dynamic subtest: vecs0
[640.733738] Dynamic subtest vecs0: SUCCESS (0.073s)
[640.747886] Starting dynamic subtest: ccs0
[640.814907] Dynamic subtest ccs0: SUCCESS (0.080s)
[640.817282] Subtest in-order: SUCCESS (0.432s)
[642.076671] [129/133] (390s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[642.180799] Starting subtest: fbc-psr2-sprite-plane-onoff
[642.183064] Starting dynamic subtest: eDP-1
[642.187109] Dynamic subtest eDP-1: SKIP (0.000s)
[642.191065] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[642.264485] [130/133] (390s left) gem_exec_reloc (basic-write-cpu)
[642.335567] Subtest basic-write-cpu: SKIP (0.000s)
[642.436546] [131/133] (390s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[642.544767] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[642.547016] Starting dynamic subtest: pipe-A
[642.566733] Dynamic subtest pipe-A: SKIP (0.017s)
[642.577801] Starting dynamic subtest: pipe-B
[642.597853] Dynamic subtest pipe-B: SKIP (0.030s)
[642.607499] Starting dynamic subtest: pipe-C
[642.629732] Dynamic subtest pipe-C: SKIP (0.031s)
[642.638690] Starting dynamic subtest: pipe-D
[642.661773] Dynamic subtest pipe-D: SKIP (0.031s)
[642.666298] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.113s)
[642.790912] [132/133] (390s left) kms_hdr (brightness-with-hdr)
[642.881171] Starting subtest: brightness-with-hdr
[642.887559] Subtest brightness-with-hdr: SKIP (0.000s)
[642.954093] [133/133] (390s left) gem_close_race (basic-process)
[643.027943] Starting subtest: basic-process
[643.109186] Subtest basic-process: SUCCESS (0.081s)
[643.315972] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_mmap_wc
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ctx_param
results: parsing output: 13/ for test: gem_lmem_swapping
results: parsing output: 14/ for test: kms_scaling_modes
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_spin_batch
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: i915_pm_rc6_residency
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: fbdev
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_sequence
results: parsing output: 25/ for test: core_auth
results: parsing output: 26/ for test: gem_vm_create
results: parsing output: 27/ for test: gem_pxp
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_dp_link_training
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: gem_exec_fence
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: kms_plane_alpha_blend
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_lease
results: parsing output: 45/ for test: kms_prime
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_atomic_interruptible
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_fence_thrash
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: kms_cdclk
results: parsing output: 57/ for test: gen9_exec_parse
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: kms_vrr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: i915_getparams_basic
results: parsing output: 68/ for test: kms_cursor_edge_walk
results: parsing output: 69/ for test: gen3_render_linear_blits
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: syncobj_basic
results: parsing output: 76/ for test: gem_pread
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: syncobj_basic
results: parsing output: 80/ for test: kms_dirtyfb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: sysfs_preempt_timeout
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: prime_self_import
results: parsing output: 86/ for test: kms_content_protection
results: parsing output: 87/ for test: gem_exec_async
results: parsing output: 88/ for test: kms_chamelium_hpd
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_create
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_plane_multiple
results: parsing output: 94/ for test: i915_query
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_atomic
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: prime_vgem
results: parsing output: 102/ for test: kms_plane
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: sw_sync
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: kms_properties
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_async_flips
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: api_intel_allocator
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_color
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: prime_busy
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_eventfd
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_pipe_b_c_ivb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_chamelium_frames
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: kms_hdr
results: parsing output: 132/ for test: gem_close_race
Done.