[46.109747] Initializing watchdogs
[46.109815]   /dev/watchdog0
[46.125826] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[46.131743] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[46.134510] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[46.136374] [001/154] (960s left) prime_vgem (fence-wait)
[46.236308] Starting subtest: fence-wait
[46.237051] Starting dynamic subtest: rcs0
[47.284025] Dynamic subtest rcs0: SUCCESS (1.045s)
[47.294160] Starting dynamic subtest: bcs0
[48.308192] Dynamic subtest bcs0: SUCCESS (1.037s)
[48.322298] Starting dynamic subtest: vcs0
[49.337848] Dynamic subtest vcs0: SUCCESS (1.039s)
[49.352253] Starting dynamic subtest: vcs1
[50.367445] Dynamic subtest vcs1: SUCCESS (1.039s)
[50.381012] Starting dynamic subtest: vecs0
[51.393040] Dynamic subtest vecs0: SUCCESS (1.034s)
[51.394070] Subtest fence-wait: SUCCESS (5.198s)
[51.504452] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[51.507006] [002/154] (955s left) gem_exec_parallel (contexts)
[51.549668] Starting subtest: contexts
[51.550448] Starting dynamic subtest: rcs0
[54.126988] Dynamic subtest rcs0: SUCCESS (2.585s)
[54.133201] Starting dynamic subtest: bcs0
[56.953891] Dynamic subtest bcs0: SUCCESS (2.839s)
[56.960494] Starting dynamic subtest: vcs0
[59.521888] Dynamic subtest vcs0: SUCCESS (2.576s)
[59.530059] Starting dynamic subtest: vcs1
[62.151750] Dynamic subtest vcs1: SUCCESS (2.635s)
[62.158627] Starting dynamic subtest: vecs0
[64.794798] Dynamic subtest vecs0: SUCCESS (2.647s)
[64.795641] Subtest contexts: SUCCESS (13.284s)
[64.978423] [003/154] (941s left) prime_mmap (test_correct_cpu_write)
[65.013620] Starting subtest: test_correct_cpu_write
[65.014347] Starting dynamic subtest: test_correct_cpu_write-smem
[65.015070] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[65.015889] Subtest test_correct_cpu_write: SUCCESS (0.000s)
[65.138298] [004/154] (941s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[65.235457] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[65.236897] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[65.323325] [005/154] (941s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[65.417139] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc
[65.418477] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[65.516993] [006/154] (941s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[65.610127] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[65.611694] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[65.698553] [007/154] (941s left) gem_exec_flush (basic-batch-kernel-default-wb)
[65.742185] Starting subtest: basic-batch-kernel-default-wb
[71.414179] Subtest basic-batch-kernel-default-wb: SUCCESS (5.676s)
[71.609864] [008/154] (935s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[71.705198] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[71.706593] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[71.793468] [009/154] (935s left) syncobj_wait (wait-for-submit-delayed-submit)
[71.829086] Starting subtest: wait-for-submit-delayed-submit
[71.932481] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[72.014752] [010/154] (935s left) gem_exec_gttfill (all-engines)
[72.057761] Starting subtest: all-engines
[95.988696] Subtest all-engines: SUCCESS (23.934s)
[96.175520] [011/154] (910s left) gem_render_copy (x-tiled)
[96.275101] Starting subtest: x-tiled
[96.275823] Starting dynamic subtest: smem
[96.377413] Dynamic subtest smem: SUCCESS (0.102s)
[96.378152] Subtest x-tiled: SUCCESS (0.102s)
[96.561899] [012/154] (910s left) gem_wait (await)
[96.608371] Starting subtest: await
[96.609129] Starting dynamic subtest: all-engines
[97.644344] Dynamic subtest all-engines: SUCCESS (1.036s)
[97.654319] Starting dynamic subtest: rcs0
[98.682398] Dynamic subtest rcs0: SUCCESS (1.037s)
[98.692280] Starting dynamic subtest: bcs0
[99.718363] Dynamic subtest bcs0: SUCCESS (1.035s)
[99.728675] Starting dynamic subtest: vcs0
[100.752502] Dynamic subtest vcs0: SUCCESS (1.034s)
[100.761949] Starting dynamic subtest: vcs1
[101.780269] Dynamic subtest vcs1: SUCCESS (1.027s)
[101.790106] Starting dynamic subtest: vecs0
[102.814350] Dynamic subtest vecs0: SUCCESS (1.033s)
[102.815465] Subtest await: SUCCESS (6.206s)
[103.006404] [013/154] (904s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[103.048045] Starting subtest: multi-wait-all-for-submit-submitted
[103.149808] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[103.223342] [014/154] (903s left) kms_async_flips (test-time-stamp)
[103.315528] Starting subtest: test-time-stamp
[103.437331] Starting dynamic subtest: pipe-A-HDMI-A-1
[103.561430] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.123s)
[103.686825] Starting dynamic subtest: pipe-B-HDMI-A-1
[103.782841] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.104s)
[103.905948] Starting dynamic subtest: pipe-C-HDMI-A-1
[104.006047] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.106s)
[104.131086] Starting dynamic subtest: pipe-D-HDMI-A-1
[104.216416] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.093s)
[104.217196] Subtest test-time-stamp: SUCCESS (0.901s)
[104.459980] [015/154] (902s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[104.559454] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[104.560904] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[104.643618] [016/154] (902s left) kms_plane (plane-panning-top-left)
[104.730822] Starting subtest: plane-panning-top-left
[104.732372] Starting dynamic subtest: pipe-A
[105.115264] Dynamic subtest pipe-A: SUCCESS (0.382s)
[105.122581] Starting dynamic subtest: pipe-B
[105.496015] Dynamic subtest pipe-B: SUCCESS (0.380s)
[105.496809] Subtest plane-panning-top-left: SUCCESS (0.765s)
[105.665523] [017/154] (901s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[105.702979] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[105.703678] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[105.780427] [018/154] (901s left) i915_query (query-topology-matches-eu-total)
[105.814555] Starting subtest: query-topology-matches-eu-total
[105.815344] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[105.886636] [019/154] (901s left) kms_pm_backlight (bad-brightness)
[105.976503] Subtest bad-brightness: SKIP (0.000s)
[106.019846] [020/154] (901s left) gem_exec_balancer (indices)
[106.064558] Starting subtest: indices
[107.419845] Subtest indices: SUCCESS (1.355s)
[107.609545] [021/154] (899s left) core_auth (getclient-master-drop)
[107.641849] Starting subtest: getclient-master-drop
[107.643268] Subtest getclient-master-drop: SUCCESS (0.002s)
[107.723806] [022/154] (899s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[107.813594] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[107.814361] Starting dynamic subtest: pipe-A-HDMI-A-1
[107.832480] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[107.839905] Starting dynamic subtest: pipe-B-HDMI-A-1
[107.858628] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[107.866033] Starting dynamic subtest: pipe-C-HDMI-A-1
[107.884324] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[107.891659] Starting dynamic subtest: pipe-D-HDMI-A-1
[107.909783] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[107.911148] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.012s)
[108.074736] [023/154] (899s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[108.163100] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[108.163902] Starting dynamic subtest: pipe-A-HDMI-A-1
[108.171497] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[108.178965] Starting dynamic subtest: pipe-B-HDMI-A-1
[108.186144] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[108.193536] Starting dynamic subtest: pipe-C-HDMI-A-1
[108.200851] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[108.207978] Starting dynamic subtest: pipe-D-HDMI-A-1
[108.215119] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[108.216480] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[108.417418] [024/154] (899s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[108.520781] Starting subtest: verify-pxp-stale-buf-optout-execution
[109.585621] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.065s)
[109.699774] [025/154] (897s left) kms_big_fb (linear-16bpp-rotate-180)
[109.802399] Starting subtest: linear-16bpp-rotate-180
[111.316763] Subtest linear-16bpp-rotate-180: SUCCESS (1.514s)
[111.456622] [026/154] (896s left) kms_setmode (basic-clone-single-crtc)
[111.490571] Starting subtest: basic-clone-single-crtc
[111.492765] Subtest basic-clone-single-crtc: SKIP (0.000s)
[111.571627] [027/154] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[111.665503] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[111.666973] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[111.738974] [028/154] (896s left) core_auth (basic-auth)
[111.772811] Starting subtest: basic-auth
[111.773541] Subtest basic-auth: SUCCESS (0.001s)
[111.838873] [029/154] (895s left) gem_userptr_blits (dmabuf-unsync)
[111.878726] Subtest dmabuf-unsync: SKIP (0.000s)
[111.997405] [030/154] (895s left) gem_spin_batch (user-each)
[112.040705] Starting subtest: user-each
[115.382756] Subtest user-each: SUCCESS (3.342s)
[115.564098] [031/154] (892s left) kms_cursor_crc (cursor-sliding-64x21)
[115.655869] Starting subtest: cursor-sliding-64x21
[115.660692] Starting dynamic subtest: pipe-A-HDMI-A-1
[116.858397] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.010s)
[116.866364] Starting dynamic subtest: pipe-D-HDMI-A-1
[118.614882] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.908s)
[118.615601] Subtest cursor-sliding-64x21: FAIL (2.959s)
[118.782727] [032/154] (889s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-onoff)
[118.880113] Starting subtest: hdr-2p-scndscrn-cur-indfb-onoff
[118.881498] Subtest hdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[118.968476] [033/154] (888s left) fbdev (read)
[119.007259] Starting subtest: read
[119.672639] Subtest read: SUCCESS (0.657s)
[119.719840] [034/154] (888s left) kms_color (ctm-negative)
[119.808894] Starting subtest: ctm-negative
[119.809620] Starting dynamic subtest: pipe-A-HDMI-A-1
[120.106810] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.298s)
[120.116204] Starting dynamic subtest: pipe-B-HDMI-A-1
[120.395589] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.288s)
[120.403292] Starting dynamic subtest: pipe-C-HDMI-A-1
[120.697151] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.301s)
[120.704864] Starting dynamic subtest: pipe-D-HDMI-A-1
[120.998067] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.301s)
[120.998835] Subtest ctm-negative: SUCCESS (1.190s)
[121.180850] [035/154] (886s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[121.278433] Starting subtest: fbchdr-rgb101010-draw-render
[121.279851] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[121.374269] [036/154] (886s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[121.466257] Starting subtest: fbcpsr-tiling-y
[121.467632] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[121.577258] [037/154] (886s left) gem_eio (context-create)
[121.620729] Starting subtest: context-create
[121.647044] Subtest context-create: SUCCESS (0.026s)
[121.761732] [038/154] (886s left) kms_setmode (invalid-clone-single-crtc)
[121.796888] Starting subtest: invalid-clone-single-crtc
[121.799088] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[121.854944] [039/154] (886s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-blt)
[121.948277] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-blt
[121.949701] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[122.068830] [040/154] (886s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[122.165267] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[122.166662] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[122.257716] [041/154] (886s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[122.355156] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[122.356507] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[122.456143] [042/154] (885s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[122.913496] Starting subtest: syncobj-stationary-timeline-chain-engines
[122.971107] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.066s)
[123.202639] [043/154] (885s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[123.290583] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[123.291284] Starting dynamic subtest: pipe-A-HDMI-A-1
[123.298099] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[123.305803] Starting dynamic subtest: pipe-B-HDMI-A-1
[123.312475] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[123.320094] Starting dynamic subtest: pipe-C-HDMI-A-1
[123.326778] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[123.334322] Starting dynamic subtest: pipe-D-HDMI-A-1
[123.341122] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[123.342440] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[123.543538] [044/154] (884s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[123.638660] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[123.640057] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[123.718657] [045/154] (884s left) gem_partial_pwrite_pread (writes-after-reads-display)
[123.756100] Starting subtest: writes-after-reads-display
[135.996966] Subtest writes-after-reads-display: SUCCESS (12.241s)
[136.104602] [046/154] (872s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[136.200273] Starting subtest: cursor-rapid-movement-64x64
[136.204817] Starting dynamic subtest: pipe-A-HDMI-A-1
[136.442168] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.237s)
[136.489680] Starting dynamic subtest: pipe-D-HDMI-A-1
[136.701344] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.220s)
[136.702068] Subtest cursor-rapid-movement-64x64: SUCCESS (0.502s)
[136.866353] [047/154] (871s left) gem_ctx_persistence (legacy-engines-mixed)
[136.907695] Starting subtest: legacy-engines-mixed
[136.908419] Starting dynamic subtest: render
[136.950454] Dynamic subtest render: SUCCESS (0.042s)
[136.969206] Starting dynamic subtest: bsd1
[136.995652] Dynamic subtest bsd1: SUCCESS (0.044s)
[137.013314] Starting dynamic subtest: bsd2
[137.046809] Dynamic subtest bsd2: SUCCESS (0.049s)
[137.065673] Starting dynamic subtest: blt
[137.104794] Dynamic subtest blt: SUCCESS (0.056s)
[137.123826] Starting dynamic subtest: vebox
[137.159667] Dynamic subtest vebox: SUCCESS (0.053s)
[137.160898] Subtest legacy-engines-mixed: SUCCESS (0.252s)
[137.246617] [048/154] (871s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite)
[137.340132] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite
[137.341539] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[137.433894] [049/154] (871s left) kms_pm_rpm (pc8-residency)
[138.837353] Starting subtest: pc8-residency
[138.839359] Subtest pc8-residency: SKIP (0.000s)
[139.025742] [050/154] (869s left) kms_feature_discovery (psr1)
[139.116523] Starting subtest: psr1
[139.118051] Subtest psr1: SKIP (0.000s)
[139.184508] [051/154] (869s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[139.273689] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[139.318756] [052/154] (869s left) kms_chamelium_color (ctm-red-to-blue)
[139.408683] Subtest ctm-red-to-blue: SKIP (0.000s)
[139.453454] [053/154] (869s left) i915_pm_rps (engine-order)
[139.493458] Starting subtest: engine-order
[143.196192] Subtest engine-order: SUCCESS (3.694s)
[143.291777] [054/154] (865s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[143.386353] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[143.387814] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[143.498516] [055/154] (865s left) kms_chamelium_hpd (hdmi-hpd)
[143.640037] Subtest hdmi-hpd: SKIP (0.000s)
[143.746926] [056/154] (865s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[143.840679] Starting subtest: hdr-rgb565-draw-pwrite
[143.842087] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[143.935089] [057/154] (865s left) gem_render_copy_redux (flink-interruptible)
[143.973181] Starting subtest: flink-interruptible
[144.770481] Subtest flink-interruptible: SUCCESS (0.797s)
[144.893735] [058/154] (864s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-pwrite)
[144.988749] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-pwrite
[144.990189] Subtest psrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[145.088331] [059/154] (863s left) perf_pmu (busy-accuracy-2)
[145.125472] Starting subtest: busy-accuracy-2
[145.126216] Starting dynamic subtest: rcs0
[148.158939] Dynamic subtest rcs0: SUCCESS (3.029s)
[148.168596] Starting dynamic subtest: bcs0
[151.190908] Dynamic subtest bcs0: SUCCESS (3.031s)
[151.200369] Starting dynamic subtest: vcs0
[154.222959] Dynamic subtest vcs0: SUCCESS (3.031s)
[154.233579] Starting dynamic subtest: vcs1
[157.255439] Dynamic subtest vcs1: SUCCESS (3.031s)
[157.264629] Starting dynamic subtest: vecs0
[160.287171] Dynamic subtest vecs0: SUCCESS (3.031s)
[160.288328] Subtest busy-accuracy-2: SUCCESS (15.157s)
[160.376992] [060/154] (848s left) kms_addfb_basic (too-wide)
[160.467767] Starting subtest: too-wide
[160.468461] Subtest too-wide: SUCCESS (0.000s)
[160.570080] [061/154] (848s left) kms_flip (2x-nonexisting-fb)
[160.658844] Starting subtest: 2x-nonexisting-fb
[160.668016] Subtest 2x-nonexisting-fb: SKIP (0.009s)
[160.739596] [062/154] (848s left) gem_ctx_param (invalid-get-ringsize)
[160.776089] Starting subtest: invalid-get-ringsize
[160.776863] Subtest invalid-get-ringsize: SUCCESS (0.000s)
[160.840878] [063/154] (848s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[160.929053] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[160.951282] Starting dynamic subtest: pipe-A-plane-0
[161.209675] Dynamic subtest pipe-A-plane-0: SUCCESS (0.258s)
[161.227273] Starting dynamic subtest: pipe-A-plane-3
[161.418311] Dynamic subtest pipe-A-plane-3: SUCCESS (0.207s)
[161.431288] Starting dynamic subtest: pipe-A-plane-5
[161.659969] Dynamic subtest pipe-A-plane-5: SUCCESS (0.239s)
[161.829604] Starting dynamic subtest: pipe-B-plane-0
[162.046380] Dynamic subtest pipe-B-plane-0: SUCCESS (0.225s)
[162.058051] Starting dynamic subtest: pipe-B-plane-3
[162.271993] Dynamic subtest pipe-B-plane-3: SUCCESS (0.224s)
[162.287199] Starting dynamic subtest: pipe-B-plane-5
[162.479738] Dynamic subtest pipe-B-plane-5: SUCCESS (0.206s)
[162.555546] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (1.626s)
[162.718726] [064/154] (846s left) kms_plane_lowres (tiling-4)
[162.815665] Starting subtest: tiling-4
[162.817058] Subtest tiling-4: SKIP (0.000s)
[162.876239] [065/154] (846s left) kms_hdr (static-swap)
[162.963980] Starting subtest: static-swap
[162.966094] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB2101010
[162.967465] Dynamic subtest pipe-A-HDMI-A-1-XRGB2101010: SKIP (0.000s)
[162.976139] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB16161616F
[162.977496] Dynamic subtest pipe-A-HDMI-A-1-XRGB16161616F: SKIP (0.000s)
[162.978856] Subtest static-swap: SKIP (0.004s)
[163.033945] [066/154] (846s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[163.122122] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[163.123559] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.000s)
[163.184495] [067/154] (846s left) kms_flip (basic-plain-flip)
[163.272670] Starting subtest: basic-plain-flip
[163.274424] Starting dynamic subtest: A-HDMI-A1
[163.950897] Dynamic subtest A-HDMI-A1: SUCCESS (0.676s)
[163.962752] Starting dynamic subtest: B-HDMI-A1
[164.620204] Dynamic subtest B-HDMI-A1: SUCCESS (0.664s)
[164.629213] Starting dynamic subtest: C-HDMI-A1
[165.287949] Dynamic subtest C-HDMI-A1: SUCCESS (0.665s)
[165.297386] Starting dynamic subtest: D-HDMI-A1
[165.954865] Dynamic subtest D-HDMI-A1: SUCCESS (0.663s)
[165.957761] Subtest basic-plain-flip: SUCCESS (2.684s)
[166.113847] [068/154] (843s left) kms_psr (fbc-psr-cursor-plane-move)
[166.206172] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[166.252816] [069/154] (843s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[166.348661] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[167.426775] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (1.079s)
[167.551083] [070/154] (841s left) kms_pm_dc (dc6-dpms)
[168.646160] Starting subtest: dc6-dpms
[171.991635] Subtest dc6-dpms: FAIL (3.296s)
[172.050240] [071/154] (837s left) kms_chamelium_frames (hdmi-frame-dump)
[172.203459] Subtest hdmi-frame-dump: SKIP (0.000s)
[172.306967] [072/154] (837s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[172.402215] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[172.403641] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[172.516184] [073/154] (837s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[172.609913] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[172.611414] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[172.710992] [074/154] (836s left) kms_plane_multiple (2x-tiling-4)
[172.802078] Starting subtest: 2x-tiling-4
[172.803509] Subtest 2x-tiling-4: SKIP (0.000s)
[172.859080] [075/154] (836s left) perf_pmu (busy-start)
[172.895381] Starting subtest: busy-start
[172.896133] Starting dynamic subtest: rcs0
[175.414314] Dynamic subtest rcs0: SUCCESS (2.518s)
[175.427236] Starting dynamic subtest: bcs0
[177.960860] Dynamic subtest bcs0: SUCCESS (2.517s)
[177.972401] Starting dynamic subtest: vcs0
[180.479559] Dynamic subtest vcs0: SUCCESS (2.518s)
[180.490803] Starting dynamic subtest: vcs1
[182.999489] Dynamic subtest vcs1: SUCCESS (2.519s)
[183.010705] Starting dynamic subtest: vecs0
[185.520060] Dynamic subtest vecs0: SUCCESS (2.518s)
[185.520885] Subtest busy-start: SUCCESS (12.600s)
[185.576079] [076/154] (824s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[185.667141] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[185.709307] [077/154] (824s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[185.803088] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[185.804549] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[185.882740] [078/154] (823s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[185.974805] Starting subtest: psr-rgb101010-draw-blt
[185.976216] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[186.071421] [079/154] (823s left) i915_pm_rps (thresholds-idle-park)
[186.111189] Starting subtest: thresholds-idle-park
[186.111914] Starting dynamic subtest: gt0
[201.532947] Dynamic subtest gt0: SUCCESS (15.410s)
[201.533966] Subtest thresholds-idle-park: SUCCESS (15.412s)
[201.598700] [080/154] (808s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[201.700755] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[201.702332] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[201.824798] [081/154] (808s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[201.859480] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[201.907648] [082/154] (808s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[201.996332] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[202.036957] [083/154] (808s left) gem_create (create-ext-placement-each)
[202.195442] Starting subtest: create-ext-placement-each
[202.196519] Subtest create-ext-placement-each: SUCCESS (0.000s)
[202.299156] [084/154] (807s left) gem_mmap_wc (fault-concurrent)
[202.333641] Starting subtest: fault-concurrent
[202.412808] Subtest fault-concurrent: SUCCESS (0.079s)
[202.474798] [085/154] (807s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[202.571382] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[202.572853] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[202.679360] [086/154] (807s left) syncobj_timeline (host-signal-points)
[202.715404] Starting subtest: host-signal-points
[202.722241] Subtest host-signal-points: SUCCESS (0.007s)
[202.784218] [087/154] (807s left) gem_exec_reloc (basic-wc-gtt)
[202.822681] Starting subtest: basic-wc-gtt
[202.828655] Subtest basic-wc-gtt: SUCCESS (0.006s)
[202.940823] [088/154] (807s left) kms_flip (flip-vs-expired-vblank-interruptible)
[203.034039] Starting subtest: flip-vs-expired-vblank-interruptible
[203.036909] Starting dynamic subtest: A-HDMI-A1
[210.717576] Dynamic subtest A-HDMI-A1: SUCCESS (7.660s)
[210.729404] Starting dynamic subtest: B-HDMI-A1
[218.362797] Dynamic subtest B-HDMI-A1: SUCCESS (7.634s)
[218.371355] Starting dynamic subtest: C-HDMI-A1
[226.006430] Dynamic subtest C-HDMI-A1: SUCCESS (7.639s)
[226.017231] Starting dynamic subtest: D-HDMI-A1
[233.645695] Dynamic subtest D-HDMI-A1: SUCCESS (7.640s)
[233.646414] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.587s)
[233.789700] [089/154] (776s left) kms_busy (extended-pageflip-hang-newfb)
[233.886904] Starting subtest: extended-pageflip-hang-newfb
[233.888828] Starting dynamic subtest: pipe-A
[247.462777] Dynamic subtest pipe-A: SUCCESS (13.575s)
[247.475168] Starting dynamic subtest: pipe-D
[261.810914] Dynamic subtest pipe-D: SUCCESS (14.343s)
[261.813132] Subtest extended-pageflip-hang-newfb: SUCCESS (27.925s)
[261.953770] [090/154] (748s left) gem_close_race (basic-threads)
[262.002229] Starting subtest: basic-threads
[263.163987] Subtest basic-threads: SUCCESS (1.161s)
[263.348099] [091/154] (747s left) kms_addfb_basic (basic-y-tiled-legacy)
[263.382976] Starting subtest: basic-y-tiled-legacy
[263.383715] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[263.546686] [092/154] (746s left) kms_sequence (get-forked)
[263.635969] Starting subtest: get-forked
[263.637783] Starting dynamic subtest: pipe-A-HDMI-A-1
[264.878791] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.242s)
[264.889165] Starting dynamic subtest: pipe-B-HDMI-A-1
[266.122845] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.242s)
[266.133903] Starting dynamic subtest: pipe-C-HDMI-A-1
[267.368564] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.243s)
[267.379500] Starting dynamic subtest: pipe-D-HDMI-A-1
[268.601183] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.231s)
[268.601954] Subtest get-forked: SUCCESS (4.965s)
[268.744008] [093/154] (741s left) vgem_basic (dmabuf-export)
[268.787575] Starting subtest: dmabuf-export
[268.829333] Subtest dmabuf-export: SUCCESS (0.043s)
[268.923917] [094/154] (741s left) kms_flip (wf_vblank-ts-check)
[269.014620] Starting subtest: wf_vblank-ts-check
[269.017046] Starting dynamic subtest: A-HDMI-A1
[276.862013] Dynamic subtest A-HDMI-A1: SUCCESS (7.824s)
[276.870453] Starting dynamic subtest: B-HDMI-A1
[284.648315] Dynamic subtest B-HDMI-A1: SUCCESS (7.802s)
[284.660235] Starting dynamic subtest: C-HDMI-A1
[292.486640] Dynamic subtest C-HDMI-A1: SUCCESS (7.809s)
[292.494823] Starting dynamic subtest: D-HDMI-A1
[300.273832] Dynamic subtest D-HDMI-A1: SUCCESS (7.808s)
[300.276769] Subtest wf_vblank-ts-check: SUCCESS (31.262s)
[300.438822] [095/154] (710s left) api_intel_bb (blit-noreloc-purge-cache)
[300.474541] Starting subtest: blit-noreloc-purge-cache
[300.480479] Subtest blit-noreloc-purge-cache: SUCCESS (0.006s)
[300.580090] [096/154] (710s left) kms_frontbuffer_tracking (psrhdr-modesetfrombusy)
[300.678520] Starting subtest: psrhdr-modesetfrombusy
[300.680045] Subtest psrhdr-modesetfrombusy: SKIP (0.000s)
[300.777841] [097/154] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[300.869737] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[300.871199] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[300.969965] [098/154] (709s left) gem_exec_whisper (basic-forked-all)
[301.016137] Starting subtest: basic-forked-all
[303.537011] Subtest basic-forked-all: SUCCESS (2.521s)
[303.724474] [099/154] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[303.819303] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[303.820680] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[303.910253] [100/154] (706s left) syncobj_timeline (transfer-timeline-point)
[303.945725] Starting subtest: transfer-timeline-point
[303.946431] Subtest transfer-timeline-point: SUCCESS (0.000s)
[304.013178] [101/154] (706s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[304.116483] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[304.422755] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.307s)
[304.566714] [102/154] (706s left) syncobj_wait (invalid-single-wait-unsubmitted)
[304.601118] Starting subtest: invalid-single-wait-unsubmitted
[304.601833] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[304.678856] [103/154] (706s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[304.775800] Starting subtest: x-tiled-64bpp-rotate-180
[306.198726] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.422s)
[306.325856] [104/154] (704s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[306.422491] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[307.649026] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (1.228s)
[307.798373] [105/154] (703s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[307.895733] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[307.897196] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[307.996150] [106/154] (703s left) core_setmaster (master-drop-set-root)
[308.066162] Starting subtest: master-drop-set-root
[308.073169] Subtest master-drop-set-root: SUCCESS (0.007s)
[308.119279] [107/154] (702s left) i915_hangman (gt-engine-error)
[308.162358] Starting subtest: gt-engine-error
[308.163076] Starting dynamic subtest: rcs0
[308.230248] Dynamic subtest rcs0: SUCCESS (0.067s)
[308.247888] Starting dynamic subtest: bcs0
[308.306990] Dynamic subtest bcs0: SUCCESS (0.074s)
[308.326759] Starting dynamic subtest: vcs0
[308.380048] Dynamic subtest vcs0: SUCCESS (0.070s)
[308.400580] Starting dynamic subtest: vcs1
[308.450115] Dynamic subtest vcs1: SUCCESS (0.067s)
[308.468032] Starting dynamic subtest: vecs0
[308.519180] Dynamic subtest vecs0: SUCCESS (0.066s)
[308.520321] Subtest gt-engine-error: SUCCESS (0.358s)
[308.649216] [108/154] (702s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-onoff)
[308.743472] Starting subtest: psrhdr-1p-primscrn-cur-indfb-onoff
[308.744889] Subtest psrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[308.859076] [109/154] (702s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[308.954312] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[308.955839] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[309.073109] [110/154] (702s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[309.170040] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[309.171483] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[309.262879] [111/154] (702s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[309.359067] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[309.360500] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[309.465896] [112/154] (701s left) kms_vblank (ts-continuation-suspend)
[309.555495] Starting subtest: ts-continuation-suspend
[309.556237] Starting dynamic subtest: pipe-A-HDMI-A-1
[326.627802] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.634s)
[326.643316] Starting dynamic subtest: pipe-D-HDMI-A-1
[343.628607] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.336s)
[343.629344] Subtest ts-continuation-suspend: SUCCESS (2.976s)
[356.860486] [113/154] (667s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[356.963458] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[356.964843] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[357.061515] [114/154] (667s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[357.158319] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[357.159685] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[357.236015] [115/154] (667s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[357.327148] Starting subtest: cursorB-vs-flipB-atomic-transitions
[357.328610] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[357.386304] [116/154] (667s left) kms_psr (psr2-dpms)
[357.476582] Subtest psr2-dpms: SKIP (0.000s)
[357.523022] [117/154] (667s left) gem_mmap_offset (bad-object)
[357.558234] Starting subtest: bad-object
[357.558925] Subtest bad-object: SUCCESS (0.001s)
[357.662052] [118/154] (666s left) gem_exec_params (no-vebox)
[357.699220] Starting subtest: no-vebox
[357.699983] Subtest no-vebox: SUCCESS (0.001s)
[357.808065] [119/154] (666s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[357.842628] Starting subtest: invalid-single-wait-all-unsubmitted
[357.843412] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[357.922269] [120/154] (666s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[357.957250] Starting subtest: cpuset-medium-copy-odd
[365.057330] Subtest cpuset-medium-copy-odd: SUCCESS (7.156s)
[365.128829] [121/154] (659s left) perf (blocking)
[365.267494] Starting subtest: blocking
[365.268254] Starting dynamic subtest: 0-rcs0
[375.323614] Dynamic subtest 0-rcs0: SUCCESS (10.050s)
[375.324627] Subtest blocking: SUCCESS (10.051s)
[375.391320] [122/154] (649s left) kms_cursor_legacy (forked-move)
[375.488915] Starting subtest: forked-move
[375.489684] Starting dynamic subtest: pipe-A
[380.911780] Dynamic subtest pipe-A: SUCCESS (5.420s)
[380.922363] Starting dynamic subtest: pipe-B
[386.365464] Dynamic subtest pipe-B: SUCCESS (5.429s)
[386.380085] Starting dynamic subtest: pipe-C
[391.793145] Dynamic subtest pipe-C: SUCCESS (5.424s)
[391.803850] Starting dynamic subtest: pipe-D
[397.221565] Dynamic subtest pipe-D: SUCCESS (5.426s)
[397.240888] Starting dynamic subtest: all-pipes
[402.663055] Dynamic subtest all-pipes: SUCCESS (5.440s)
[402.664067] Subtest forked-move: SUCCESS (27.148s)
[402.720982] [123/154] (622s left) kms_psr (fbc-pr-cursor-plane-onoff)
[402.816843] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[402.864927] [124/154] (622s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[402.957839] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[404.173132] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (1.216s)
[404.294380] [125/154] (620s left) gem_exec_balancer (semaphore)
[404.337713] Starting subtest: semaphore
[405.658698] Subtest semaphore: SUCCESS (1.321s)
[405.840641] [126/154] (619s left) syncobj_timeline (wait-zero-handles)
[405.877388] Starting subtest: wait-zero-handles
[405.878174] Subtest wait-zero-handles: SUCCESS (0.000s)
[405.936949] [127/154] (619s left) kms_psr (psr-sprite-blt)
[406.027796] Subtest psr-sprite-blt: SKIP (0.000s)
[406.073620] [128/154] (618s left) gem_ctx_param (get-priority-new-ctx)
[406.109326] Starting subtest: get-priority-new-ctx
[406.110228] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[406.171496] [129/154] (618s left) kms_joiner (basic-big-joiner)
[406.262332] Starting subtest: basic-big-joiner
[406.263701] Subtest basic-big-joiner: SKIP (0.000s)
[406.319836] [130/154] (618s left) kms_cursor_crc (cursor-offscreen-64x21)
[406.416130] Starting subtest: cursor-offscreen-64x21
[406.421232] Starting dynamic subtest: pipe-A-HDMI-A-1
[407.673347] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.252s)
[407.718317] Starting dynamic subtest: pipe-D-HDMI-A-1
[408.941345] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.235s)
[408.942180] Subtest cursor-offscreen-64x21: SUCCESS (2.526s)
[409.116668] [131/154] (616s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[409.215266] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[409.216730] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[409.302085] [132/154] (615s left) gen7_exec_parse (batch-without-end)
[409.340369] Subtest batch-without-end: SKIP (0.000s)
[409.382787] [133/154] (615s left) kms_content_protection (atomic)
[409.474491] Starting subtest: atomic
[409.480025] Subtest atomic: SKIP (0.004s)
[409.560288] [134/154] (615s left) gem_pwrite (basic-random)
[409.595976] Starting subtest: basic-random
[415.072194] Subtest basic-random: SUCCESS (5.443s)
[415.148268] [135/154] (610s left) gem_exec_schedule (preempt-queue)
[415.255555] Starting subtest: preempt-queue
[415.256290] Starting dynamic subtest: rcs0
[415.369929] Dynamic subtest rcs0: SUCCESS (0.108s)
[415.380103] Starting dynamic subtest: bcs0
[415.471139] Dynamic subtest bcs0: SUCCESS (0.106s)
[415.481669] Starting dynamic subtest: vcs0
[415.579050] Dynamic subtest vcs0: SUCCESS (0.107s)
[415.590921] Starting dynamic subtest: vcs1
[415.684597] Dynamic subtest vcs1: SUCCESS (0.104s)
[415.695329] Starting dynamic subtest: vecs0
[415.790487] Dynamic subtest vecs0: SUCCESS (0.105s)
[415.791298] Subtest preempt-queue: SUCCESS (0.536s)
[416.101338] [136/154] (609s left) gem_exec_schedule (u-submit-early-slice)
[416.149665] Starting subtest: u-submit-early-slice
[416.150527] Starting dynamic subtest: rcs0
[416.178157] Dynamic subtest rcs0: SUCCESS (0.028s)
[416.189348] Starting dynamic subtest: bcs0
[416.207116] Dynamic subtest bcs0: SUCCESS (0.028s)
[416.218323] Starting dynamic subtest: vcs0
[416.237038] Dynamic subtest vcs0: SUCCESS (0.029s)
[416.248509] Starting dynamic subtest: vcs1
[416.268068] Dynamic subtest vcs1: SUCCESS (0.030s)
[416.281978] Starting dynamic subtest: vecs0
[416.299264] Dynamic subtest vecs0: SUCCESS (0.030s)
[416.300137] Subtest u-submit-early-slice: SUCCESS (0.150s)
[416.598541] [137/154] (608s left) gem_exec_whisper (basic-queues-forked)
[416.642757] Starting subtest: basic-queues-forked
[418.801606] Subtest basic-queues-forked: SUCCESS (2.150s)
[418.982089] [138/154] (606s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[419.084754] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[419.086175] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[419.187431] [139/154] (606s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[419.281147] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[419.282729] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[419.410130] [140/154] (606s left) kms_psr (psr2-primary-render)
[419.499943] Subtest psr2-primary-render: SKIP (0.000s)
[419.548792] [141/154] (606s left) syncobj_timeline (invalid-query-one-illegal-handle)
[419.584327] Starting subtest: invalid-query-one-illegal-handle
[419.585050] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[419.662840] [142/154] (606s left) gem_exec_reloc (basic-cpu-wc-active)
[419.701270] Starting subtest: basic-cpu-wc-active
[419.833898] Subtest basic-cpu-wc-active: SUCCESS (0.124s)
[419.955378] [143/154] (605s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[420.050994] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[420.052355] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[420.167097] [144/154] (605s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-blt)
[420.260486] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-blt
[420.261969] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[420.363751] [145/154] (605s left) syncobj_wait (wait-for-submit-snapshot)
[420.401274] Starting subtest: wait-for-submit-snapshot
[420.483902] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[420.561340] [146/154] (605s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[420.649299] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[420.650017] Starting dynamic subtest: pipe-A-HDMI-A-1
[420.656864] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[420.666657] Starting dynamic subtest: pipe-B-HDMI-A-1
[420.673378] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[420.683014] Starting dynamic subtest: pipe-C-HDMI-A-1
[420.689704] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[420.699136] Starting dynamic subtest: pipe-D-HDMI-A-1
[420.706143] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[420.707555] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[420.914448] [147/154] (604s left) kms_pipe_crc_basic (hang-read-crc)
[421.006919] Starting subtest: hang-read-crc
[421.009147] Starting dynamic subtest: pipe-A-HDMI-A-1
[421.667570] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.658s)
[421.678902] Starting dynamic subtest: pipe-B-HDMI-A-1
[422.268482] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.599s)
[422.283500] Starting dynamic subtest: pipe-C-HDMI-A-1
[422.868492] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.598s)
[422.879437] Starting dynamic subtest: pipe-D-HDMI-A-1
[423.454643] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.584s)
[423.455431] Subtest hang-read-crc: SUCCESS (2.448s)
[423.570071] [148/154] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[423.678249] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[423.679606] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[423.770906] [149/154] (602s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[423.806536] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[423.912087] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[423.987489] [150/154] (602s left) kms_flip (2x-modeset-vs-vblank-race)
[424.079632] Starting subtest: 2x-modeset-vs-vblank-race
[424.088585] Subtest 2x-modeset-vs-vblank-race: SKIP (0.009s)
[424.159710] [151/154] (601s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[424.202078] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[424.202817] Starting dynamic subtest: smem
[424.308698] Dynamic subtest smem: SUCCESS (0.105s)
[424.309438] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.107s)
[424.488059] [152/154] (601s left) gen9_exec_parse (unaligned-access)
[424.526728] Subtest unaligned-access: SKIP (0.000s)
[424.571712] [153/154] (601s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[424.661256] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[424.663082] Starting dynamic subtest: pipe-A-valid-mode
[425.480020] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.817s)
[425.480751] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.819s)
[425.623131] [154/154] (600s left) kms_atomic_transition (plane-all-transition-nonblocking)
[425.714467] Starting subtest: plane-all-transition-nonblocking
[425.715164] Starting dynamic subtest: pipe-A-HDMI-A-1
[427.657531] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.942s)
[427.744427] Starting dynamic subtest: pipe-B-HDMI-A-1
[429.773015] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.041s)
[429.838204] Subtest plane-all-transition-nonblocking: SUCCESS (4.126s)
[430.012183] Closing watchdogs
results: parsing output: 0/ for test: prime_vgem
results: parsing output: 1/ for test: gem_exec_parallel
results: parsing output: 2/ for test: prime_mmap
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_exec_flush
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: gem_exec_gttfill
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: gem_wait
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_async_flips
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: i915_query
results: parsing output: 18/ for test: kms_pm_backlight
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: core_auth
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: gem_pxp
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_setmode
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: core_auth
results: parsing output: 28/ for test: gem_userptr_blits
results: parsing output: 29/ for test: gem_spin_batch
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: fbdev
results: parsing output: 33/ for test: kms_color
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_eio
results: parsing output: 37/ for test: kms_setmode
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_partial_pwrite_pread
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: kms_feature_discovery
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_chamelium_color
results: parsing output: 52/ for test: i915_pm_rps
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_render_copy_redux
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: gem_ctx_param
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: kms_plane_lowres
results: parsing output: 64/ for test: kms_hdr
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_pm_dc
results: parsing output: 70/ for test: kms_chamelium_frames
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_plane_multiple
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: i915_pm_rps
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_pipe_b_c_ivb
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: gem_create
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_busy
results: parsing output: 89/ for test: gem_close_race
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_sequence
results: parsing output: 92/ for test: vgem_basic
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: api_intel_bb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: core_setmaster
results: parsing output: 106/ for test: i915_hangman
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_vblank
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: gem_mmap_offset
results: parsing output: 117/ for test: gem_exec_params
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_ctx_param
results: parsing output: 128/ for test: kms_joiner
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gen7_exec_parse
results: parsing output: 132/ for test: kms_content_protection
results: parsing output: 133/ for test: gem_pwrite
results: parsing output: 134/ for test: gem_exec_schedule
results: parsing output: 135/ for test: gem_exec_schedule
results: parsing output: 136/ for test: gem_exec_whisper
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_psr
results: parsing output: 140/ for test: syncobj_timeline
results: parsing output: 141/ for test: gem_exec_reloc
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: syncobj_wait
results: parsing output: 145/ for test: kms_ccs
results: parsing output: 146/ for test: kms_pipe_crc_basic
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: syncobj_timeline
results: parsing output: 149/ for test: kms_flip
results: parsing output: 150/ for test: gem_render_copy
results: parsing output: 151/ for test: gen9_exec_parse
results: parsing output: 152/ for test: kms_flip_scaled_crc
results: parsing output: 153/ for test: kms_atomic_transition
Done.