[62.159773] Initializing watchdogs
[62.159822]   /dev/watchdog0
[62.174081] [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]
[62.178660] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.181050] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.184401] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[62.309963] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[69.388983] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (7.079s)
[69.532745] [002/133] (953s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[69.639346] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[69.641656] Starting dynamic subtest: pipe-A-eDP-1
[69.664844] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[69.674195] Starting dynamic subtest: pipe-B-eDP-1
[69.695761] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[69.702944] Starting dynamic subtest: pipe-C-eDP-1
[69.725305] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[69.732332] Starting dynamic subtest: pipe-D-eDP-1
[69.755696] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[69.760320] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[71.904593] [003/133] (950s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[72.003046] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[72.005372] Starting dynamic subtest: pipe-A-eDP-1
[72.028501] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[72.038066] Starting dynamic subtest: pipe-B-eDP-1
[72.059728] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[72.067093] Starting dynamic subtest: pipe-C-eDP-1
[72.088657] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[72.097892] Starting dynamic subtest: pipe-D-eDP-1
[72.121767] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[72.126045] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[74.274756] [004/133] (948s left) gem_softpin (overlap)
[74.344562] Starting subtest: overlap
[75.359559] Subtest overlap: SUCCESS (1.013s)
[75.498483] [005/133] (947s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[75.618186] Starting subtest: basic-flip-after-cursor-varying-size
[76.567136] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.948s)
[77.410326] [006/133] (945s left) kms_setmode (invalid-clone-single-crtc)
[77.458921] Starting subtest: invalid-clone-single-crtc
[77.465642] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[77.550836] [007/133] (945s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[77.615499] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[77.681911] [008/133] (945s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[77.777997] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[77.780359] Starting dynamic subtest: pipe-A
[77.803107] Dynamic subtest pipe-A: SKIP (0.022s)
[77.812939] Starting dynamic subtest: pipe-B
[77.841211] Dynamic subtest pipe-B: SKIP (0.037s)
[77.848547] Starting dynamic subtest: pipe-C
[77.878706] Dynamic subtest pipe-C: SKIP (0.037s)
[77.885924] Starting dynamic subtest: pipe-D
[77.911455] Dynamic subtest pipe-D: SKIP (0.033s)
[77.915057] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.130s)
[78.025128] [009/133] (944s left) i915_suspend (debugfs-reader)
[78.080783] Starting subtest: debugfs-reader
[96.343534] Subtest debugfs-reader: SUCCESS (3.258s)
[96.470573] [010/133] (926s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[96.578363] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[96.580587] Starting dynamic subtest: pipe-A-eDP-1
[103.429072] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.829s)
[103.438608] Starting dynamic subtest: pipe-B-eDP-1
[110.880184] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.437s)
[110.882507] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (14.269s)
[111.747910] [011/133] (911s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[111.814160] Starting subtest: invalid-bsd2-flag-on-vebox
[111.816478] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[111.933051] [012/133] (911s left) gem_mmap_offset (mmap-unmap)
[111.991664] Starting subtest: mmap-unmap
[111.993876] Starting dynamic subtest: smem0
[135.582343] Dynamic subtest smem0: SUCCESS (23.582s)
[135.585200] Subtest mmap-unmap: SUCCESS (23.582s)
[135.696848] [013/133] (887s left) kms_content_protection (lic-type-0)
[135.847559] Starting subtest: lic-type-0
[135.852207] Subtest lic-type-0: SKIP (0.000s)
[135.979658] [014/133] (887s left) gem_exec_balancer (parallel-bb-first)
[136.252452] Starting subtest: parallel-bb-first
[137.209373] Subtest parallel-bb-first: SUCCESS (0.960s)
[137.940631] [015/133] (885s left) gem_reg_read (timestamp-moving)
[138.000526] Starting subtest: timestamp-moving
[139.002616] Subtest timestamp-moving: SUCCESS (1.001s)
[139.076931] [016/133] (884s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[139.169002] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[146.111105] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.944s)
[146.225035] [017/133] (877s left) syncobj_timeline (single-wait-signaled)
[146.289273] Starting subtest: single-wait-signaled
[146.291741] Subtest single-wait-signaled: SUCCESS (0.001s)
[146.386068] [018/133] (877s left) gem_exec_reloc (basic-gtt-read-active)
[146.450062] Subtest basic-gtt-read-active: SKIP (0.000s)
[146.510768] [019/133] (876s left) syncobj_wait (reset-multiple-signaled)
[146.570711] Starting subtest: reset-multiple-signaled
[146.573084] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[146.681187] [020/133] (876s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[146.779175] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[147.880576] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.101s)
[148.037592] [021/133] (875s left) kms_vblank (ts-continuation-modeset)
[148.124371] Starting subtest: ts-continuation-modeset
[148.126262] Starting dynamic subtest: pipe-A-eDP-1
[149.583160] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.459s)
[149.597253] Starting dynamic subtest: pipe-D-eDP-1
[151.759045] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.171s)
[151.761343] Subtest ts-continuation-modeset: SUCCESS (3.634s)
[152.559977] [022/133] (871s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[152.664094] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[152.668077] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[152.757817] [023/133] (870s left) kms_dp_aux_dev
[153.116139] [024/133] (870s left) gem_mmap_wc (close)
[153.182178] Subtest close: SKIP (0.000s)
[153.253085] [025/133] (870s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[153.345662] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[158.017401] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.675s)
[159.151374] [026/133] (864s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[159.241469] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[159.243688] Starting dynamic subtest: pipe-A-eDP-1
[159.304099] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[159.312244] Starting dynamic subtest: pipe-B-eDP-1
[159.369712] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[159.380480] Starting dynamic subtest: pipe-C-eDP-1
[159.437864] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[159.447459] Starting dynamic subtest: pipe-D-eDP-1
[159.504917] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[159.509501] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[161.521999] [027/133] (862s left) gem_ctx_persistence (idempotent)
[161.579033] Starting subtest: idempotent
[161.581540] Subtest idempotent: SUCCESS (0.000s)
[161.683277] [028/133] (862s left) prime_mmap (test_reprime)
[161.739201] Starting subtest: test_reprime
[161.741454] Starting dynamic subtest: test_reprime-smem
[161.786663] Dynamic subtest test_reprime-smem: SUCCESS (0.047s)
[161.789353] Subtest test_reprime: SUCCESS (0.048s)
[161.889504] [029/133] (862s left) kms_psr (fbc-psr-sprite-plane-move)
[161.982211] Starting subtest: fbc-psr-sprite-plane-move
[161.984424] Starting dynamic subtest: eDP-1
[161.988880] Dynamic subtest eDP-1: SKIP (0.000s)
[161.993272] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[162.053526] [030/133] (861s left) syncobj_eventfd (invalid-illegal-handle)
[162.101653] Starting subtest: invalid-illegal-handle
[162.103862] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[162.198093] [031/133] (861s left) gem_exec_schedule (preempt-contexts)
[162.263612] Starting subtest: preempt-contexts
[162.265512] Starting dynamic subtest: rcs0
[162.313887] Dynamic subtest rcs0: SUCCESS (0.056s)
[162.323031] Starting dynamic subtest: bcs0
[162.368943] Dynamic subtest bcs0: SUCCESS (0.055s)
[162.377439] Starting dynamic subtest: vcs0
[162.421392] Dynamic subtest vcs0: SUCCESS (0.052s)
[162.434313] Starting dynamic subtest: vcs1
[162.475420] Dynamic subtest vcs1: SUCCESS (0.054s)
[162.483978] Starting dynamic subtest: vecs0
[162.525849] Dynamic subtest vecs0: SUCCESS (0.050s)
[162.534238] Starting dynamic subtest: ccs0
[162.584353] Dynamic subtest ccs0: SUCCESS (0.058s)
[162.586115] Subtest preempt-contexts: SUCCESS (0.328s)
[163.976368] [032/133] (860s left) kms_atomic_interruptible (universal-setplane-primary)
[164.067786] Starting subtest: universal-setplane-primary
[164.070011] Starting dynamic subtest: pipe-A-eDP-1
[171.466171] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.396s)
[171.468597] Subtest universal-setplane-primary: SUCCESS (7.398s)
[172.297891] [033/133] (851s left) sw_sync (sync_multi_consumer)
[172.346332] Starting subtest: sync_multi_consumer
[172.776681] Subtest sync_multi_consumer: SUCCESS (0.431s)
[172.837973] [034/133] (851s left) gem_exec_fence (parallel)
[173.004482] Starting subtest: parallel
[173.006864] Starting dynamic subtest: rcs0
[175.158186] Dynamic subtest rcs0: SUCCESS (2.153s)
[175.171277] Starting dynamic subtest: bcs0
[177.315240] Dynamic subtest bcs0: SUCCESS (2.155s)
[177.329331] Starting dynamic subtest: vcs0
[179.465276] Dynamic subtest vcs0: SUCCESS (2.148s)
[179.473990] Starting dynamic subtest: vcs1
[181.620952] Dynamic subtest vcs1: SUCCESS (2.154s)
[181.631561] Starting dynamic subtest: vecs0
[183.772491] Dynamic subtest vecs0: SUCCESS (2.150s)
[183.782866] Starting dynamic subtest: ccs0
[185.925934] Dynamic subtest ccs0: SUCCESS (2.152s)
[185.928012] Subtest parallel: SUCCESS (12.918s)
[187.970923] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true
[187.974929] [035/133] (836s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[188.117111] Starting subtest: 2x-long-cursor-vs-flip-atomic
[188.121460] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[188.261110] [036/133] (835s left) syncobj_wait (invalid-reset-one-illegal-handle)
[188.312723] Starting subtest: invalid-reset-one-illegal-handle
[188.314997] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[188.433692] [037/133] (835s left) i915_hangman (gt-engine-error)
[188.505989] Starting subtest: gt-engine-error
[188.507921] Starting dynamic subtest: rcs0
[189.841819] Dynamic subtest rcs0: SUCCESS (1.334s)
[189.854172] Starting dynamic subtest: bcs0
[191.888211] Dynamic subtest bcs0: SUCCESS (2.044s)
[191.900753] Starting dynamic subtest: vcs0
[193.871198] Dynamic subtest vcs0: SUCCESS (1.981s)
[193.882671] Starting dynamic subtest: vcs1
[195.856185] Dynamic subtest vcs1: SUCCESS (1.983s)
[195.869669] Starting dynamic subtest: vecs0
[197.840240] Dynamic subtest vecs0: SUCCESS (1.983s)
[197.851670] Starting dynamic subtest: ccs0
[199.888643] Dynamic subtest ccs0: SUCCESS (2.046s)
[199.891480] Subtest gt-engine-error: SUCCESS (11.386s)
[199.971159] [038/133] (824s left) kms_prop_blob (invalid-get-prop-any)
[200.034410] Starting subtest: invalid-get-prop-any
[200.036888] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[200.133027] [039/133] (824s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[200.238962] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[200.241374] Starting dynamic subtest: pipe-A-eDP-1
[200.265001] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[200.276312] Starting dynamic subtest: pipe-B-eDP-1
[200.298045] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[200.307395] Starting dynamic subtest: pipe-C-eDP-1
[200.330058] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[200.340169] Starting dynamic subtest: pipe-D-eDP-1
[200.362586] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[200.367296] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s)
[202.554971] [040/133] (821s left) device_reset (cold-reset-bound)
[202.609299] Starting subtest: cold-reset-bound
[202.613973] Subtest cold-reset-bound: SKIP (0.000s)
[202.681612] [041/133] (821s left) gem_flink_basic (flink-lifetime)
[202.738049] Starting subtest: flink-lifetime
[202.740201] Subtest flink-lifetime: SUCCESS (0.002s)
[202.837415] [042/133] (821s left) kms_addfb_basic (addfb25-4-tiled)
[202.937635] Starting subtest: addfb25-4-tiled
[202.939790] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[203.036504] [043/133] (821s left) gem_ppgtt (shrink-vs-evict-pinned)
[203.104480] Starting subtest: shrink-vs-evict-pinned
[208.903625] Subtest shrink-vs-evict-pinned: SUCCESS (5.801s)
[208.962700] [044/133] (815s left) gem_exec_whisper (basic-fds-priority-all)
[209.037447] Starting subtest: basic-fds-priority-all
[231.720165] Subtest basic-fds-priority-all: SUCCESS (22.680s)
[231.906008] [045/133] (792s left) kms_flip (2x-flip-vs-dpms)
[232.004991] Starting subtest: 2x-flip-vs-dpms
[232.014491] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[232.132337] [046/133] (792s left) perf_pmu (semaphore-wait)
[232.187649] Starting subtest: semaphore-wait
[232.189989] Starting dynamic subtest: rcs0
[232.704019] Dynamic subtest rcs0: SUCCESS (0.515s)
[232.718129] Starting dynamic subtest: bcs0
[233.218196] Dynamic subtest bcs0: SUCCESS (0.510s)
[233.230252] Starting dynamic subtest: vcs0
[233.732336] Dynamic subtest vcs0: SUCCESS (0.511s)
[233.744380] Starting dynamic subtest: vcs1
[234.245724] Dynamic subtest vcs1: SUCCESS (0.511s)
[234.257850] Starting dynamic subtest: vecs0
[234.759592] Dynamic subtest vecs0: SUCCESS (0.510s)
[234.771552] Starting dynamic subtest: ccs0
[235.274552] Dynamic subtest ccs0: SUCCESS (0.512s)
[235.277395] Subtest semaphore-wait: SUCCESS (3.087s)
[235.393466] [047/133] (789s left) perf (invalid-oa-metric-set-id)
[235.515627] Starting subtest: invalid-oa-metric-set-id
[235.531695] Subtest invalid-oa-metric-set-id: SUCCESS (0.015s)
[235.570644] [048/133] (789s left) sysfs_preempt_timeout (timeout)
[235.619992] Starting subtest: timeout
[235.622439] Starting dynamic subtest: vecs0
[244.910814] Dynamic subtest vecs0: SUCCESS (9.289s)
[244.922391] Starting dynamic subtest: ccs0
[246.158086] Dynamic subtest ccs0: SUCCESS (1.244s)
[246.169770] Starting dynamic subtest: vcs0
[255.921208] Dynamic subtest vcs0: SUCCESS (9.757s)
[255.933273] Starting dynamic subtest: bcs0
[257.112914] Dynamic subtest bcs0: SUCCESS (1.191s)
[257.124434] Starting dynamic subtest: rcs0
[258.355605] Dynamic subtest rcs0: SUCCESS (1.239s)
[258.365841] Starting dynamic subtest: vcs1
[267.886359] Dynamic subtest vcs1: SUCCESS (9.524s)
[267.889294] Subtest timeout: SUCCESS (32.258s)
[267.965943] [049/133] (756s left) perf_pmu (busy-idle-no-semaphores)
[268.004432] Starting subtest: busy-idle-no-semaphores
[268.006871] Starting dynamic subtest: rcs0
[268.677294] Dynamic subtest rcs0: SUCCESS (0.672s)
[268.689351] Starting dynamic subtest: bcs0
[269.332085] Dynamic subtest bcs0: SUCCESS (0.652s)
[269.344359] Starting dynamic subtest: vcs0
[269.985852] Dynamic subtest vcs0: SUCCESS (0.652s)
[269.998564] Starting dynamic subtest: vcs1
[271.514951] Dynamic subtest vcs1: SUCCESS (1.526s)
[271.527420] Starting dynamic subtest: vecs0
[273.497871] Dynamic subtest vecs0: SUCCESS (1.981s)
[273.510410] Starting dynamic subtest: ccs0
[275.545626] Dynamic subtest ccs0: SUCCESS (2.045s)
[275.548378] Subtest busy-idle-no-semaphores: SUCCESS (7.541s)
[275.663520] [050/133] (749s left) gen9_exec_parse (bb-chained)
[275.735725] Subtest bb-chained: SKIP (0.000s)
[275.804939] [051/133] (748s left) kms_big_fb (linear-64bpp-rotate-180)
[275.899597] Starting subtest: linear-64bpp-rotate-180
[277.423434] Subtest linear-64bpp-rotate-180: SUCCESS (1.524s)
[277.611538] [052/133] (747s left) kms_flip (flip-vs-suspend-interruptible)
[277.710545] Starting subtest: flip-vs-suspend-interruptible
[277.712960] Starting dynamic subtest: A-eDP1
[327.363815] Dynamic subtest A-eDP1: SUCCESS (4.498s)
[327.375729] Starting dynamic subtest: B-eDP1
[376.335444] Dynamic subtest B-eDP1: SUCCESS (4.519s)
[376.346345] Starting dynamic subtest: C-eDP1
[425.343167] Dynamic subtest C-eDP1: SUCCESS (4.525s)
[425.355561] Starting dynamic subtest: D-eDP1
[474.359360] Dynamic subtest D-eDP1: SUCCESS (4.539s)
[474.362106] Subtest flip-vs-suspend-interruptible: SUCCESS (18.091s)
[475.569667] [053/133] (549s left) gem_spin_batch (legacy-resubmit-new)
[475.633898] Starting subtest: legacy-resubmit-new
[475.636337] Starting dynamic subtest: default
[475.644532] Dynamic subtest default: SUCCESS (0.010s)
[475.655596] Starting dynamic subtest: render
[475.658211] Dynamic subtest render: SUCCESS (0.003s)
[475.667802] Starting dynamic subtest: bsd
[475.670352] Dynamic subtest bsd: SUCCESS (0.004s)
[475.679404] Starting dynamic subtest: bsd1
[475.681524] Dynamic subtest bsd1: SUCCESS (0.007s)
[475.690336] Starting dynamic subtest: bsd2
[475.692424] Dynamic subtest bsd2: SUCCESS (0.003s)
[475.701305] Starting dynamic subtest: blt
[475.703723] Dynamic subtest blt: SUCCESS (0.003s)
[475.712623] Starting dynamic subtest: vebox
[475.715117] Dynamic subtest vebox: SUCCESS (0.003s)
[475.717879] Subtest legacy-resubmit-new: SUCCESS (0.039s)
[477.468794] [054/133] (547s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[477.566832] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[477.572126] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[477.666022] [055/133] (547s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[477.765635] Starting subtest: extended-pageflip-modeset-hang-oldfb
[477.767643] Starting dynamic subtest: pipe-A
[485.696992] Dynamic subtest pipe-A: SUCCESS (7.905s)
[485.707015] Starting dynamic subtest: pipe-D
[494.326927] Dynamic subtest pipe-D: SUCCESS (8.617s)
[494.329899] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.527s)
[495.183223] [056/133] (529s left) kms_atomic (plane-overlay-legacy)
[495.292120] Starting subtest: plane-overlay-legacy
[495.295205] Starting dynamic subtest: pipe-A-eDP-1
[495.712529] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[495.715181] Subtest plane-overlay-legacy: SUCCESS (0.422s)
[496.518859] [057/133] (528s left) kms_psr (psr-sprite-plane-move)
[496.615568] Starting subtest: psr-sprite-plane-move
[496.618194] Starting dynamic subtest: eDP-1
[498.635535] Dynamic subtest eDP-1: SUCCESS (2.019s)
[498.638211] Subtest psr-sprite-plane-move: SUCCESS (2.019s)
[499.453801] [058/133] (525s left) gem_exec_create (madvise)
[499.515141] Starting subtest: madvise
[499.517919] Starting dynamic subtest: smem
[521.448846] Dynamic subtest smem: SUCCESS (21.937s)
[521.451702] Subtest madvise: SUCCESS (21.938s)
[522.345829] [059/133] (502s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[522.454174] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[522.459636] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[522.570758] [060/133] (502s left) gem_lmem_swapping (parallel-random)
[522.627290] Subtest parallel-random: SKIP (0.000s)
[522.678487] [061/133] (502s left) kms_flip (2x-plain-flip)
[522.782041] Starting subtest: 2x-plain-flip
[522.790800] Subtest 2x-plain-flip: SKIP (0.011s)
[522.870400] [062/133] (502s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[522.920476] Starting subtest: multi-wait-for-submit-submitted-signaled
[522.922499] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[523.037704] [063/133] (502s left) gem_mmap_gtt (fault-concurrent-x)
[523.100357] Subtest fault-concurrent-X: SKIP (0.000s)
[523.167481] [064/133] (502s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[523.273305] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[529.888506] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.622s)
[530.018561] [065/133] (495s left) prime_mmap_coherency (write)
[530.081308] Starting subtest: write
[535.459130] Subtest write: SUCCESS (5.376s)
[535.594715] [066/133] (489s left) gem_ctx_freq (sysfs)
[535.664793] Starting subtest: sysfs
[535.667527] Starting dynamic subtest: gt0
[541.181753] Dynamic subtest gt0: SUCCESS (5.519s)
[541.191812] Starting dynamic subtest: gt1
[582.372906] Dynamic subtest gt1: SUCCESS (41.184s)
[582.376110] Subtest sysfs: SUCCESS (46.706s)
[582.497413] [067/133] (443s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[582.606296] Starting subtest: fbcpsr-slowdraw
[607.798951] Subtest fbcpsr-slowdraw: SUCCESS (25.197s)
[607.925989] [068/133] (417s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[608.073016] Starting subtest: 2x-cursor-vs-flip-atomic
[608.077989] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[608.230935] [069/133] (417s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[608.353071] Starting subtest: flip-vs-cursor-toggle
[617.257528] Subtest flip-vs-cursor-toggle: SUCCESS (8.903s)
[618.120885] [070/133] (407s left) kms_pm_rpm (modeset-lpsp)
[619.657066] Starting subtest: modeset-lpsp
[621.117156] Subtest modeset-lpsp: SUCCESS (1.461s)
[621.222691] [071/133] (404s left) gem_exec_schedule (fairslice)
[621.308907] Starting subtest: fairslice
[621.311297] Starting dynamic subtest: rcs0
[623.326275] Dynamic subtest rcs0: SUCCESS (2.020s)
[623.337970] Starting dynamic subtest: bcs0
[625.346998] Dynamic subtest bcs0: SUCCESS (2.017s)
[625.358145] Starting dynamic subtest: vcs0
[627.362703] Dynamic subtest vcs0: SUCCESS (2.018s)
[627.374904] Starting dynamic subtest: vcs1
[629.386540] Dynamic subtest vcs1: SUCCESS (2.021s)
[629.398881] Starting dynamic subtest: vecs0
[631.409277] Dynamic subtest vecs0: SUCCESS (2.021s)
[631.420711] Starting dynamic subtest: ccs0
[633.429124] Dynamic subtest ccs0: SUCCESS (2.019s)
[633.431679] Subtest fairslice: SUCCESS (12.121s)
[633.726620] [072/133] (392s left) api_intel_bb (object-reloc-keep-cache)
[633.782181] Starting subtest: object-reloc-keep-cache
[633.790362] Subtest object-reloc-keep-cache: SKIP (0.007s)
[633.914688] [073/133] (391s left) perf_pmu (busy-check-all)
[633.960300] Starting subtest: busy-check-all
[633.962975] Starting dynamic subtest: rcs0
[634.512349] Dynamic subtest rcs0: SUCCESS (0.556s)
[634.527995] Starting dynamic subtest: bcs0
[635.070167] Dynamic subtest bcs0: SUCCESS (0.555s)
[635.082897] Starting dynamic subtest: vcs0
[636.389418] Dynamic subtest vcs0: SUCCESS (1.315s)
[636.405633] Starting dynamic subtest: vcs1
[638.373316] Dynamic subtest vcs1: SUCCESS (1.980s)
[638.386334] Starting dynamic subtest: vecs0
[640.421613] Dynamic subtest vecs0: SUCCESS (2.045s)
[640.433695] Starting dynamic subtest: ccs0
[640.976638] Dynamic subtest ccs0: SUCCESS (0.553s)
[640.979647] Subtest busy-check-all: SUCCESS (7.020s)
[641.081549] [074/133] (384s left) gem_ctx_exec (basic-close-race)
[641.146136] Starting subtest: basic-close-race
[647.136474] Subtest basic-close-race: SUCCESS (5.987s)
[647.269174] [075/133] (378s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[647.381023] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[647.385925] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[647.476511] [076/133] (378s left) kms_flip (plain-flip-ts-check)
[647.579127] Starting subtest: plain-flip-ts-check
[647.581902] Starting dynamic subtest: A-eDP1
[656.473974] Dynamic subtest A-eDP1: SUCCESS (8.892s)
[656.485762] Starting dynamic subtest: B-eDP1
[665.303057] Dynamic subtest B-eDP1: SUCCESS (8.824s)
[665.315211] Starting dynamic subtest: C-eDP1
[674.124227] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[674.134304] Starting dynamic subtest: D-eDP1
[682.962493] Dynamic subtest D-eDP1: SUCCESS (8.835s)
[682.968045] Subtest plain-flip-ts-check: SUCCESS (35.381s)
[684.153317] [077/133] (341s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[684.261996] Starting subtest: fbc-psr2-cursor-mmap-gtt
[684.264313] Starting dynamic subtest: eDP-1
[684.269308] Dynamic subtest eDP-1: SKIP (0.000s)
[684.273892] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.003s)
[684.349749] [078/133] (341s left) api_intel_bb (blit-reloc-keep-cache)
[684.402331] Starting subtest: blit-reloc-keep-cache
[684.407284] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[684.529455] [079/133] (341s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[684.619311] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[684.623907] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[684.705060] [080/133] (341s left) gem_softpin (evict-active)
[684.765003] Starting subtest: evict-active
[684.771001] Subtest evict-active: SUCCESS (0.006s)
[684.884615] [081/133] (341s left) kms_chamelium_frames (vga-frame-dump)
[685.263532] Subtest vga-frame-dump: SKIP (0.000s)
[686.057452] [082/133] (340s left) kms_color (ctm-green-to-red)
[686.146102] Starting subtest: ctm-green-to-red
[686.148581] Starting dynamic subtest: pipe-A-eDP-1
[686.880648] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s)
[686.890711] Starting dynamic subtest: pipe-B-eDP-1
[688.317466] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.436s)
[688.327293] Starting dynamic subtest: pipe-C-eDP-1
[689.656495] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.340s)
[689.666027] Starting dynamic subtest: pipe-D-eDP-1
[691.001217] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[691.004059] Subtest ctm-green-to-red: SUCCESS (4.855s)
[691.811088] [083/133] (334s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[691.958869] Starting subtest: cursor-rapid-movement-32x32
[692.005365] Subtest cursor-rapid-movement-32x32: SKIP (0.042s)
[692.276351] [084/133] (334s left) sw_sync (sync_merge_invalid)
[692.314223] Starting subtest: sync_merge_invalid
[692.341723] Subtest sync_merge_invalid: SUCCESS (0.029s)
[692.419680] [085/133] (333s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[692.483889] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[692.543381] [086/133] (333s left) kms_pm_dc (dc5-dpms-negative)
[693.637105] Starting subtest: dc5-dpms-negative
[693.642585] Subtest dc5-dpms-negative: SKIP (0.000s)
[693.710154] [087/133] (332s left) i915_pm_rpm (gem-idle)
[695.542913] Starting subtest: gem-idle
[701.755296] Subtest gem-idle: SUCCESS (6.212s)
[702.121915] [088/133] (324s left) kms_lease (page-flip-implicit-plane)
[703.344434] Starting subtest: page-flip-implicit-plane
[703.349366] Starting dynamic subtest: pipe-A-eDP-1
[703.823021] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.482s)
[703.834073] Starting dynamic subtest: pipe-B-eDP-1
[704.958049] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.134s)
[704.971103] Starting dynamic subtest: pipe-C-eDP-1
[706.082883] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[706.093662] Starting dynamic subtest: pipe-D-eDP-1
[707.208082] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[707.210996] Subtest page-flip-implicit-plane: SUCCESS (3.869s)
[708.056571] [089/133] (318s left) gem_wait (busy)
[708.129332] Starting subtest: busy
[708.132157] Starting dynamic subtest: all-engines
[709.348611] Dynamic subtest all-engines: SUCCESS (1.218s)
[709.361298] Starting dynamic subtest: rcs0
[709.890976] Dynamic subtest rcs0: SUCCESS (0.539s)
[709.903356] Starting dynamic subtest: bcs0
[710.430029] Dynamic subtest bcs0: SUCCESS (0.537s)
[710.442336] Starting dynamic subtest: vcs0
[712.420625] Dynamic subtest vcs0: SUCCESS (1.991s)
[712.433475] Starting dynamic subtest: vcs1
[714.405196] Dynamic subtest vcs1: SUCCESS (1.982s)
[714.416562] Starting dynamic subtest: vecs0
[716.388519] Dynamic subtest vecs0: SUCCESS (1.981s)
[716.401297] Starting dynamic subtest: ccs0
[716.931542] Dynamic subtest ccs0: SUCCESS (0.541s)
[716.934361] Subtest busy: SUCCESS (8.804s)
[717.131873] [090/133] (309s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[717.242271] Starting subtest: 4-tiled-64bpp-rotate-90
[717.262652] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[717.382153] [091/133] (309s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[717.474264] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[722.147279] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.678s)
[723.274615] [092/133] (303s left) gem_render_copy_redux (flink-interruptible)
[723.338975] Starting subtest: flink-interruptible
[724.123607] Subtest flink-interruptible: SUCCESS (0.786s)
[724.245591] [093/133] (302s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[724.315732] Starting subtest: invalid-single-wait-all-unsubmitted
[724.317825] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[724.423576] [094/133] (302s left) kms_addfb_basic (unused-modifier)
[724.486151] Starting subtest: unused-modifier
[724.488424] Subtest unused-modifier: SUCCESS (0.000s)
[724.628404] [095/133] (302s left) i915_drm_fdinfo (memory-info-idle)
[724.668174] Starting subtest: memory-info-idle
[724.670445] Starting dynamic subtest: smem0
[724.715551] Dynamic subtest smem0: SUCCESS (0.049s)
[724.717651] Subtest memory-info-idle: SUCCESS (0.049s)
[724.793631] [096/133] (302s left) gem_eio (kms)
[725.051908] Starting subtest: kms
[744.649788] Subtest kms: SUCCESS (19.598s)
[745.840171] [097/133] (281s left) gem_exec_fence (basic-busy)
[746.020476] Starting subtest: basic-busy
[746.023236] Starting dynamic subtest: rcs0
[746.099448] Dynamic subtest rcs0: SUCCESS (0.079s)
[746.110215] Starting dynamic subtest: bcs0
[746.157674] Dynamic subtest bcs0: SUCCESS (0.056s)
[746.167817] Starting dynamic subtest: vcs0
[746.215337] Dynamic subtest vcs0: SUCCESS (0.056s)
[746.226823] Starting dynamic subtest: vcs1
[746.267636] Dynamic subtest vcs1: SUCCESS (0.050s)
[746.277900] Starting dynamic subtest: vecs0
[746.320839] Dynamic subtest vecs0: SUCCESS (0.051s)
[746.334294] Starting dynamic subtest: ccs0
[746.379323] Dynamic subtest ccs0: SUCCESS (0.055s)
[746.382298] Subtest basic-busy: SUCCESS (0.360s)
[748.473605] [098/133] (278s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[748.573286] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[748.578525] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[748.646168] [099/133] (278s left) gem_fence_thrash (bo-write-verify-threaded-y)
[748.692096] Starting subtest: bo-write-verify-threaded-y
[748.708722] Subtest bo-write-verify-threaded-y: SKIP (0.015s)
[748.773943] [100/133] (278s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[748.872220] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[748.877272] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[748.969981] [101/133] (278s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[749.063996] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[749.068783] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[749.165682] [102/133] (277s left) kms_plane_multiple (tiling-4)
[749.262000] Starting subtest: tiling-4
[749.264503] Starting dynamic subtest: pipe-A-eDP-1
[753.065291] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.803s)
[753.075682] Starting dynamic subtest: pipe-B-eDP-1
[757.488078] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.420s)
[757.499066] Starting dynamic subtest: pipe-C-eDP-1
[761.825525] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.339s)
[761.836021] Starting dynamic subtest: pipe-D-eDP-1
[766.167428] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.339s)
[766.170055] Subtest tiling-4: SUCCESS (16.906s)
[766.987460] [103/133] (260s left) kms_feature_discovery (psr2)
[767.092288] Starting subtest: psr2
[767.095229] Subtest psr2: SUCCESS (0.000s)
[767.168217] [104/133] (260s left) kms_psr (psr-cursor-render)
[767.254675] Starting subtest: psr-cursor-render
[767.257010] Starting dynamic subtest: eDP-1
[768.966973] Dynamic subtest eDP-1: SUCCESS (1.711s)
[768.969592] Subtest psr-cursor-render: SUCCESS (1.712s)
[769.842912] [105/133] (257s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[769.964973] Starting subtest: basic-busy-flip-before-cursor-varying-size
[769.970168] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[770.156167] [106/133] (257s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[770.276532] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[770.281967] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[770.381285] [107/133] (256s left) syncobj_timeline (host-signal-ordered)
[770.431413] Starting subtest: host-signal-ordered
[770.434089] Subtest host-signal-ordered: SUCCESS (0.000s)
[770.535833] [108/133] (256s left) kms_addfb_basic (invalid-set-prop)
[770.586427] Starting subtest: invalid-set-prop
[770.589139] Subtest invalid-set-prop: SUCCESS (0.000s)
[770.724574] [109/133] (256s left) kms_psr (psr2-basic)
[770.816687] Starting subtest: psr2-basic
[770.818896] Starting dynamic subtest: eDP-1
[772.415086] Dynamic subtest eDP-1: SUCCESS (1.596s)
[772.417938] Subtest psr2-basic: SUCCESS (1.598s)
[773.213761] [110/133] (254s left) gem_mmap_gtt (basic-write-gtt)
[773.278741] Subtest basic-write-gtt: SKIP (0.000s)
[773.341457] [111/133] (254s left) kms_cursor_crc (cursor-onscreen-32x10)
[773.509377] Starting subtest: cursor-onscreen-32x10
[773.555554] Subtest cursor-onscreen-32x10: SKIP (0.042s)
[773.845578] [112/133] (253s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[773.947202] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[773.950367] Starting dynamic subtest: pipe-A-eDP-1
[774.042280] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[774.053813] Starting dynamic subtest: pipe-B-eDP-1
[775.181096] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s)
[775.186560] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.239s)
[776.364777] [113/133] (251s left) kms_chamelium_color (ctm-0-50)
[776.449667] Subtest ctm-0-50: SKIP (0.000s)
[776.501428] [114/133] (251s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[776.602159] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[783.278412] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.678s)
[783.404024] [115/133] (244s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[783.787399] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[784.604512] [116/133] (243s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[784.694212] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[784.696908] Starting dynamic subtest: pipe-A-default-mode
[785.878490] Dynamic subtest pipe-A-default-mode: SKIP (1.182s)
[785.883443] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.183s)
[786.025918] [117/133] (241s left) gem_exec_schedule (preempt-queue-contexts-chain)
[786.098413] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[786.384811] [118/133] (241s left) kms_getfb (getfb-handle-not-fb)
[786.469323] Starting subtest: getfb-handle-not-fb
[786.471847] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[786.564297] [119/133] (241s left) kms_joiner (basic-force-ultra-joiner)
[786.673301] Starting subtest: basic-force-ultra-joiner
[786.678112] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[786.743422] [120/133] (241s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[786.828904] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[786.923226] [121/133] (241s left) kms_sequence (get-idle)
[787.021293] Starting subtest: get-idle
[787.024088] Starting dynamic subtest: pipe-A-eDP-1
[788.834761] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.815s)
[788.846731] Starting dynamic subtest: pipe-B-eDP-1
[791.324986] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.489s)
[791.340342] Starting dynamic subtest: pipe-C-eDP-1
[793.736293] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.409s)
[793.748055] Starting dynamic subtest: pipe-D-eDP-1
[796.172140] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.434s)
[796.175032] Subtest get-idle: SUCCESS (9.152s)
[796.987344] [122/133] (231s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[797.087560] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[797.778729] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.693s)
[797.963199] [123/133] (230s left) fbdev (nullptr)
[798.012831] Starting subtest: nullptr
[798.015613] Subtest nullptr: SUCCESS (0.000s)
[798.076516] [124/133] (230s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[798.170077] Starting subtest: y-tiled-64bpp-rotate-0
[798.175109] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[798.269331] [125/133] (229s left) kms_plane (plane-position-covered)
[798.364479] Starting subtest: plane-position-covered
[798.904801] Starting dynamic subtest: pipe-A-plane-1
[800.170035] Dynamic subtest pipe-A-plane-1: SUCCESS (1.266s)
[800.181630] Starting dynamic subtest: pipe-A-plane-2
[801.522483] Dynamic subtest pipe-A-plane-2: SUCCESS (1.352s)
[801.534154] Starting dynamic subtest: pipe-A-plane-3
[802.850848] Dynamic subtest pipe-A-plane-3: SUCCESS (1.324s)
[802.862282] Starting dynamic subtest: pipe-A-plane-4
[804.194730] Dynamic subtest pipe-A-plane-4: SUCCESS (1.345s)
[804.208240] Starting dynamic subtest: pipe-A-plane-5
[804.220942] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[805.449230] Starting dynamic subtest: pipe-B-plane-1
[806.766137] Dynamic subtest pipe-B-plane-1: SUCCESS (1.323s)
[806.776924] Starting dynamic subtest: pipe-B-plane-2
[808.118183] Dynamic subtest pipe-B-plane-2: SUCCESS (1.353s)
[808.132022] Starting dynamic subtest: pipe-B-plane-3
[809.413305] Dynamic subtest pipe-B-plane-3: SUCCESS (1.294s)
[809.432307] Starting dynamic subtest: pipe-B-plane-4
[810.743584] Dynamic subtest pipe-B-plane-4: SUCCESS (1.329s)
[810.754716] Starting dynamic subtest: pipe-B-plane-5
[810.770320] Dynamic subtest pipe-B-plane-5: SUCCESS (0.027s)
[810.773125] Subtest plane-position-covered: SUCCESS (12.405s)
[811.618291] [126/133] (216s left) perf (low-oa-exponent-permissions)
[811.721011] Starting subtest: low-oa-exponent-permissions
[811.758319] Subtest low-oa-exponent-permissions: SUCCESS (0.041s)
[811.808269] [127/133] (216s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[811.861107] Starting subtest: x-tiled-to-vebox-yf-tiled
[811.866781] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[812.046809] [128/133] (216s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[812.103303] Starting subtest: yf-tiled-to-vebox-x-tiled
[812.109186] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[812.297168] [129/133] (216s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[812.404586] Starting subtest: psr-2p-primscrn-spr-indfb-move
[812.409745] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[812.495156] [130/133] (215s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[812.592839] Starting subtest: basic-max-pipe-crc-check
[812.597352] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[812.643616] [131/133] (215s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[812.700324] Starting subtest: multi-wait-all-for-submit-submitted
[812.801333] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[812.891985] [132/133] (215s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[813.001787] Starting subtest: psr-indfb-scaledprimary
[818.749017] Subtest psr-indfb-scaledprimary: SUCCESS (5.750s)
[818.863329] [133/133] (209s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[818.967158] Starting subtest: yf-tiled-64bpp-rotate-270
[818.972272] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[819.063029] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_softpin
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_setmode
results: parsing output: 6/ for test: gem_fenced_exec_thrash
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: i915_suspend
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: gem_exec_params
results: parsing output: 11/ for test: gem_mmap_offset
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: gem_reg_read
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_dp_aux_dev
results: parsing output: 23/ for test: gem_mmap_wc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: prime_mmap
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: syncobj_eventfd
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_atomic_interruptible
results: parsing output: 32/ for test: sw_sync
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: i915_hangman
results: parsing output: 37/ for test: kms_prop_blob
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: device_reset
results: parsing output: 40/ for test: gem_flink_basic
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: gem_ppgtt
results: parsing output: 43/ for test: gem_exec_whisper
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: sysfs_preempt_timeout
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: gen9_exec_parse
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: gem_spin_batch
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_busy
results: parsing output: 55/ for test: kms_atomic
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_exec_create
results: parsing output: 58/ for test: kms_plane
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_mmap_gtt
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: prime_mmap_coherency
results: parsing output: 65/ for test: gem_ctx_freq
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: gem_ctx_exec
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_softpin
results: parsing output: 80/ for test: kms_chamelium_frames
results: parsing output: 81/ for test: kms_color
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: sw_sync
results: parsing output: 84/ for test: kms_pipe_b_c_ivb
results: parsing output: 85/ for test: kms_pm_dc
results: parsing output: 86/ for test: i915_pm_rpm
results: parsing output: 87/ for test: kms_lease
results: parsing output: 88/ for test: gem_wait
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_render_copy_redux
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: gem_eio
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: gem_fence_thrash
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_plane_multiple
results: parsing output: 102/ for test: kms_feature_discovery
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_chamelium_color
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_chamelium_edid
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_getfb
results: parsing output: 118/ for test: kms_joiner
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_sequence
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: fbdev
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_plane
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_multipipe_modeset
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_big_fb
Done.