[57.565077] Initializing watchdogs
[57.565203]   /dev/watchdog0
[57.580849] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.585728] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.588242] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.591857] [001/154] (960s left) prime_vgem (fence-wait)
[57.724939] Starting subtest: fence-wait
[57.726989] Starting dynamic subtest: rcs0
[58.768749] Dynamic subtest rcs0: SUCCESS (1.036s)
[58.777125] Starting dynamic subtest: bcs0
[59.831098] Dynamic subtest bcs0: SUCCESS (1.056s)
[59.841831] Starting dynamic subtest: vcs0
[60.881366] Dynamic subtest vcs0: SUCCESS (1.043s)
[60.891921] Starting dynamic subtest: vcs1
[62.274247] Dynamic subtest vcs1: SUCCESS (1.386s)
[62.284635] Starting dynamic subtest: vecs0
[63.320957] Dynamic subtest vecs0: SUCCESS (1.042s)
[63.331229] Starting dynamic subtest: ccs0
[64.365947] Dynamic subtest ccs0: SUCCESS (1.041s)
[64.368758] Subtest fence-wait: SUCCESS (6.610s)
[64.485341] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[64.488408] [002/154] (953s left) gem_exec_parallel (contexts)
[64.555733] Starting subtest: contexts
[64.558216] Starting dynamic subtest: rcs0
[68.047044] Dynamic subtest rcs0: SUCCESS (3.482s)
[68.057774] Starting dynamic subtest: bcs0
[71.532734] Dynamic subtest bcs0: SUCCESS (3.480s)
[71.541102] Starting dynamic subtest: vcs0
[75.801570] Dynamic subtest vcs0: SUCCESS (4.264s)
[75.813660] Starting dynamic subtest: vcs1
[79.768302] Dynamic subtest vcs1: SUCCESS (3.964s)
[79.776317] Starting dynamic subtest: vecs0
[83.764621] Dynamic subtest vecs0: SUCCESS (3.995s)
[83.772641] Starting dynamic subtest: ccs0
[87.253055] Dynamic subtest ccs0: SUCCESS (3.486s)
[87.255577] Subtest contexts: SUCCESS (22.675s)
[87.438802] [003/154] (930s left) prime_mmap (test_correct_cpu_write)
[87.503068] Starting subtest: test_correct_cpu_write
[87.505273] Starting dynamic subtest: test_correct_cpu_write-smem
[87.507128] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[87.509052] Subtest test_correct_cpu_write: SUCCESS (0.000s)
[87.618545] [004/154] (930s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[87.721758] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[94.280138] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.563s)
[94.391204] [005/154] (923s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[94.505448] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc
[94.509434] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[94.595780] [006/154] (923s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[94.696647] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[94.700674] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[94.781363] [007/154] (923s left) gem_exec_flush (basic-batch-kernel-default-wb)
[94.845931] Starting subtest: basic-batch-kernel-default-wb
[102.191200] Subtest basic-batch-kernel-default-wb: SUCCESS (7.346s)
[102.376618] [008/154] (915s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[102.479218] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[102.483560] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[102.560352] [009/154] (915s left) syncobj_wait (wait-for-submit-delayed-submit)
[102.615853] Starting subtest: wait-for-submit-delayed-submit
[102.720491] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[102.798658] [010/154] (915s left) gem_exec_gttfill (all-engines)
[102.854883] Starting subtest: all-engines
[125.929498] Subtest all-engines: SUCCESS (23.071s)
[126.118618] [011/154] (892s left) gem_render_copy (x-tiled)
[126.214061] Starting subtest: x-tiled
[126.216550] Starting dynamic subtest: smem
[126.268407] Dynamic subtest smem: SUCCESS (0.054s)
[126.270902] Subtest x-tiled: SUCCESS (0.055s)
[126.485573] [012/154] (892s left) gem_wait (await)
[126.555052] Starting subtest: await
[126.557509] Starting dynamic subtest: all-engines
[127.677100] Dynamic subtest all-engines: SUCCESS (1.121s)
[127.693821] Starting dynamic subtest: rcs0
[128.740482] Dynamic subtest rcs0: SUCCESS (1.063s)
[128.758386] Starting dynamic subtest: bcs0
[129.801914] Dynamic subtest bcs0: SUCCESS (1.061s)
[129.818908] Starting dynamic subtest: vcs0
[130.859922] Dynamic subtest vcs0: SUCCESS (1.057s)
[130.877764] Starting dynamic subtest: vcs1
[131.915228] Dynamic subtest vcs1: SUCCESS (1.053s)
[131.930701] Starting dynamic subtest: vecs0
[132.967177] Dynamic subtest vecs0: SUCCESS (1.052s)
[132.983561] Starting dynamic subtest: ccs0
[134.023057] Dynamic subtest ccs0: SUCCESS (1.054s)
[134.026034] Subtest await: SUCCESS (7.467s)
[134.219917] [013/154] (884s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[134.278664] Starting subtest: multi-wait-all-for-submit-submitted
[134.382064] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[134.457483] [014/154] (884s left) kms_async_flips (test-time-stamp)
[134.556779] Starting subtest: test-time-stamp
[134.930237] Starting dynamic subtest: pipe-A-eDP-1
[135.727734] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s)
[136.111246] Starting dynamic subtest: pipe-B-eDP-1
[136.966962] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.861s)
[137.346343] Starting dynamic subtest: pipe-C-eDP-1
[138.187647] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.845s)
[138.551979] Starting dynamic subtest: pipe-D-eDP-1
[139.326637] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.781s)
[139.329076] Subtest test-time-stamp: SUCCESS (4.769s)
[140.497343] [015/154] (878s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[140.606568] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[140.610955] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[140.701329] [016/154] (877s left) kms_plane (plane-panning-top-left)
[140.800407] Starting subtest: plane-panning-top-left
[140.803072] Starting dynamic subtest: pipe-A
[142.497892] Dynamic subtest pipe-A: SUCCESS (1.699s)
[142.508070] Starting dynamic subtest: pipe-B
[144.974527] Dynamic subtest pipe-B: SUCCESS (2.475s)
[144.976888] Subtest plane-panning-top-left: SUCCESS (4.176s)
[145.852566] [017/154] (872s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[145.912956] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[145.915300] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[146.054498] [018/154] (872s left) i915_query (query-topology-matches-eu-total)
[146.107386] Starting subtest: query-topology-matches-eu-total
[146.110058] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[146.222978] [019/154] (872s left) kms_pm_backlight (bad-brightness)
[146.315961] Starting subtest: bad-brightness
[146.390912] Starting dynamic subtest: eDP-1
[146.702429] Dynamic subtest eDP-1: SUCCESS (0.309s)
[146.704735] Subtest bad-brightness: SUCCESS (0.386s)
[147.605445] [020/154] (871s left) gem_exec_balancer (indices)
[147.671590] Starting subtest: indices
[150.248032] Subtest indices: SUCCESS (2.574s)
[150.549081] [021/154] (868s left) core_auth (getclient-master-drop)
[150.584435] Starting subtest: getclient-master-drop
[150.614843] Subtest getclient-master-drop: SUCCESS (0.030s)
[150.738781] [022/154] (868s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[150.829573] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[150.831681] Starting dynamic subtest: pipe-A-eDP-1
[150.890087] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[150.899359] Starting dynamic subtest: pipe-B-eDP-1
[150.959631] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[150.972296] Starting dynamic subtest: pipe-C-eDP-1
[151.031614] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[151.041095] Starting dynamic subtest: pipe-D-eDP-1
[151.100601] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[151.104901] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.007s)
[153.149537] [023/154] (865s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[153.244295] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[153.246721] Starting dynamic subtest: pipe-A-eDP-1
[153.268280] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[153.279461] Starting dynamic subtest: pipe-B-eDP-1
[153.299060] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[153.307352] Starting dynamic subtest: pipe-C-eDP-1
[153.326920] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[153.334989] Starting dynamic subtest: pipe-D-eDP-1
[153.354660] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[153.356861] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[155.507750] [024/154] (863s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[155.637721] Starting subtest: verify-pxp-stale-buf-optout-execution
[156.702268] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.063s)
[156.843085] [025/154] (862s left) kms_big_fb (linear-16bpp-rotate-180)
[156.950333] Starting subtest: linear-16bpp-rotate-180
[158.272351] Subtest linear-16bpp-rotate-180: SUCCESS (1.323s)
[158.394960] [026/154] (860s left) kms_setmode (basic-clone-single-crtc)
[158.450878] Starting subtest: basic-clone-single-crtc
[158.456449] Subtest basic-clone-single-crtc: SKIP (0.000s)
[158.556890] [027/154] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[158.654987] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[158.658697] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[158.746548] [028/154] (860s left) core_auth (basic-auth)
[158.795242] Starting subtest: basic-auth
[158.797068] Subtest basic-auth: SUCCESS (0.001s)
[158.885779] [029/154] (860s left) gem_userptr_blits (dmabuf-unsync)
[158.945162] Subtest dmabuf-unsync: SKIP (0.000s)
[159.072658] [030/154] (860s left) gem_spin_batch (user-each)
[159.133539] Starting subtest: user-each
[162.490719] Subtest user-each: SUCCESS (3.356s)
[164.364473] [031/154] (854s left) kms_cursor_crc (cursor-sliding-64x21)
[164.568997] Starting subtest: cursor-sliding-64x21
[164.619475] Subtest cursor-sliding-64x21: SKIP (0.047s)
[164.856616] [032/154] (854s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-onoff)
[164.953859] Starting subtest: hdr-2p-scndscrn-cur-indfb-onoff
[164.958454] Subtest hdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[165.051704] [033/154] (854s left) fbdev (read)
[165.090825] Starting subtest: read
[165.622042] Subtest read: SUCCESS (0.528s)
[165.691767] [034/154] (853s left) kms_color (ctm-negative)
[165.789818] Starting subtest: ctm-negative
[165.791819] Starting dynamic subtest: pipe-A-eDP-1
[166.523583] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[166.534403] Starting dynamic subtest: pipe-B-eDP-1
[167.917901] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.396s)
[167.926848] Starting dynamic subtest: pipe-C-eDP-1
[169.285382] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[169.293989] Starting dynamic subtest: pipe-D-eDP-1
[170.624120] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[170.626463] Subtest ctm-negative: SUCCESS (4.836s)
[171.451435] [035/154] (848s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[171.562487] Starting subtest: fbchdr-rgb101010-draw-render
[171.567177] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[171.662321] [036/154] (847s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[171.766090] Starting subtest: fbcpsr-tiling-y
[171.770360] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[171.881414] [037/154] (847s left) gem_eio (context-create)
[172.092848] Starting subtest: context-create
[172.391227] Subtest context-create: SUCCESS (0.299s)
[172.506094] [038/154] (847s left) kms_setmode (invalid-clone-single-crtc)
[172.559951] Starting subtest: invalid-clone-single-crtc
[172.565475] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[172.679399] [039/154] (847s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-blt)
[172.774768] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-blt
[172.778375] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[172.893458] [040/154] (846s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[172.993069] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[172.996427] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[173.091702] [041/154] (846s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[173.187461] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[173.190877] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[173.292238] [042/154] (846s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[173.848388] Starting subtest: syncobj-stationary-timeline-chain-engines
[173.975386] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.130s)
[175.393373] [043/154] (844s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[175.486440] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[175.488670] Starting dynamic subtest: pipe-A-eDP-1
[175.512166] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[175.525038] Starting dynamic subtest: pipe-B-eDP-1
[175.547188] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[175.556146] Starting dynamic subtest: pipe-C-eDP-1
[175.578197] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[175.587131] Starting dynamic subtest: pipe-D-eDP-1
[175.609223] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[175.613160] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[177.790133] [044/154] (842s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[177.890548] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[177.894648] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[178.017328] [045/154] (841s left) gem_partial_pwrite_pread (writes-after-reads-display)
[178.073173] Subtest writes-after-reads-display: SKIP (0.000s)
[178.144043] [046/154] (841s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[178.329663] Starting subtest: cursor-rapid-movement-64x64
[178.331924] Starting dynamic subtest: pipe-A-eDP-1
[178.898732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s)
[178.929819] Starting dynamic subtest: pipe-D-eDP-1
[180.126815] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.201s)
[180.129254] Subtest cursor-rapid-movement-64x64: SUCCESS (1.796s)
[180.965498] [047/154] (839s left) gem_ctx_persistence (legacy-engines-mixed)
[181.017248] Starting subtest: legacy-engines-mixed
[181.019630] Starting dynamic subtest: render
[181.088695] Dynamic subtest render: SUCCESS (0.071s)
[181.102301] Starting dynamic subtest: bsd1
[181.114527] Dynamic subtest bsd1: SUCCESS (0.024s)
[181.123659] Starting dynamic subtest: bsd2
[181.185771] Dynamic subtest bsd2: SUCCESS (0.070s)
[181.197651] Starting dynamic subtest: blt
[181.232717] Dynamic subtest blt: SUCCESS (0.045s)
[181.245240] Starting dynamic subtest: vebox
[181.277700] Dynamic subtest vebox: SUCCESS (0.043s)
[181.280222] Subtest legacy-engines-mixed: SUCCESS (0.261s)
[181.356207] [048/154] (838s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite)
[181.451514] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite
[181.456182] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[181.542586] [049/154] (838s left) kms_pm_rpm (pc8-residency)
[183.475330] Starting subtest: pc8-residency
[183.481782] Subtest pc8-residency: SKIP (0.000s)
[183.875022] [050/154] (836s left) kms_feature_discovery (psr1)
[183.972227] Starting subtest: psr1
[183.974066] Subtest psr1: SUCCESS (0.000s)
[184.044105] [051/154] (836s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[184.134708] Starting subtest: fbc-psr2-sprite-mmap-cpu
[184.136970] Starting dynamic subtest: eDP-1
[184.141167] Dynamic subtest eDP-1: SKIP (0.000s)
[184.145254] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[184.207997] [052/154] (836s left) kms_chamelium_color (ctm-red-to-blue)
[184.313155] Subtest ctm-red-to-blue: SKIP (0.000s)
[184.360159] [053/154] (835s left) i915_pm_rps (engine-order)
[184.411662] Starting subtest: engine-order
[189.674497] Subtest engine-order: SUCCESS (5.260s)
[189.798664] [054/154] (830s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[189.906257] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[189.910452] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[190.001405] [055/154] (830s left) kms_chamelium_hpd (hdmi-hpd)
[190.388420] Subtest hdmi-hpd: SKIP (0.000s)
[191.182806] [056/154] (829s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[191.274810] Starting subtest: hdr-rgb565-draw-pwrite
[191.279246] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[191.373690] [057/154] (829s left) gem_render_copy_redux (flink-interruptible)
[191.437928] Starting subtest: flink-interruptible
[192.275861] Subtest flink-interruptible: SUCCESS (0.841s)
[192.424159] [058/154] (828s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-pwrite)
[192.525248] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-pwrite
[192.528801] Subtest psrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[192.625546] [059/154] (827s left) perf_pmu (busy-accuracy-2)
[192.661482] Starting subtest: busy-accuracy-2
[192.663407] Starting dynamic subtest: rcs0
[195.706961] Dynamic subtest rcs0: SUCCESS (3.043s)
[195.720040] Starting dynamic subtest: bcs0
[198.766591] Dynamic subtest bcs0: SUCCESS (3.057s)
[198.777984] Starting dynamic subtest: vcs0
[201.807959] Dynamic subtest vcs0: SUCCESS (3.041s)
[201.817665] Starting dynamic subtest: vcs1
[204.848807] Dynamic subtest vcs1: SUCCESS (3.039s)
[204.858400] Starting dynamic subtest: vecs0
[207.893052] Dynamic subtest vecs0: SUCCESS (3.043s)
[207.903225] Starting dynamic subtest: ccs0
[210.955043] Dynamic subtest ccs0: SUCCESS (3.059s)
[210.957505] Subtest busy-accuracy-2: SUCCESS (18.290s)
[211.082808] [060/154] (809s left) kms_addfb_basic (too-wide)
[211.182739] Starting subtest: too-wide
[211.184973] Subtest too-wide: SUCCESS (0.000s)
[211.300293] [061/154] (809s left) kms_flip (2x-nonexisting-fb)
[211.399533] Starting subtest: 2x-nonexisting-fb
[211.410821] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[211.498860] [062/154] (809s left) gem_ctx_param (invalid-get-ringsize)
[211.551368] Starting subtest: invalid-get-ringsize
[211.553674] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[211.653474] [063/154] (809s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[211.754540] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[211.782821] Starting dynamic subtest: pipe-A-plane-0
[212.148586] Dynamic subtest pipe-A-plane-0: SUCCESS (0.366s)
[212.159664] Starting dynamic subtest: pipe-A-plane-3
[212.482469] Dynamic subtest pipe-A-plane-3: SUCCESS (0.332s)
[213.577871] Starting dynamic subtest: pipe-B-plane-0
[213.957539] Dynamic subtest pipe-B-plane-0: SUCCESS (0.389s)
[213.968155] Starting dynamic subtest: pipe-B-plane-3
[214.302419] Dynamic subtest pipe-B-plane-3: SUCCESS (0.344s)
[214.616088] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.861s)
[215.456492] [064/154] (805s left) kms_plane_lowres (tiling-4)
[215.564415] Starting subtest: tiling-4
[215.566721] Starting dynamic subtest: pipe-A-eDP-1
[215.571340] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[215.866365] Starting dynamic subtest: pipe-B-eDP-1
[215.871078] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[215.880531] Starting dynamic subtest: pipe-C-eDP-1
[215.885223] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[215.894410] Starting dynamic subtest: pipe-D-eDP-1
[215.898998] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[215.903449] Subtest tiling-4: SKIP (0.301s)
[216.691053] [065/154] (804s left) kms_hdr (static-swap)
[216.794110] Starting subtest: static-swap
[216.796468] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[216.800768] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[216.810848] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[216.815079] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[216.819355] Subtest static-swap: SKIP (0.002s)
[216.867197] [066/154] (803s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[216.954317] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[216.956481] Starting dynamic subtest: pipe-A-default-mode
[218.152731] Dynamic subtest pipe-A-default-mode: SKIP (1.195s)
[218.157299] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.197s)
[218.333742] [067/154] (802s left) kms_flip (basic-plain-flip)
[218.426045] Starting subtest: basic-plain-flip
[218.428269] Starting dynamic subtest: A-eDP1
[220.113497] Dynamic subtest A-eDP1: SUCCESS (1.688s)
[220.125191] Starting dynamic subtest: B-eDP1
[221.767491] Dynamic subtest B-eDP1: SUCCESS (1.651s)
[221.781665] Starting dynamic subtest: C-eDP1
[223.482061] Dynamic subtest C-eDP1: SUCCESS (1.713s)
[223.494100] Starting dynamic subtest: D-eDP1
[225.113508] Dynamic subtest D-eDP1: SUCCESS (1.630s)
[225.115895] Subtest basic-plain-flip: SUCCESS (6.693s)
[226.283695] [068/154] (794s left) kms_psr (fbc-psr-cursor-plane-move)
[226.379389] Starting subtest: fbc-psr-cursor-plane-move
[226.381307] Starting dynamic subtest: eDP-1
[226.385370] Dynamic subtest eDP-1: SKIP (0.000s)
[226.389402] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[226.452148] [069/154] (794s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[226.562248] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[230.610457] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.054s)
[231.770127] [070/154] (789s left) kms_pm_dc (dc6-dpms)
[232.873222] Starting subtest: dc6-dpms
[234.936325] Subtest dc6-dpms: SUCCESS (2.062s)
[235.027385] [071/154] (786s left) kms_chamelium_frames (hdmi-frame-dump)
[235.423754] Subtest hdmi-frame-dump: SKIP (0.000s)
[236.222564] [072/154] (784s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[236.335171] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[236.339535] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[236.449218] [073/154] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[236.551711] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[236.555890] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[236.642802] [074/154] (784s left) kms_plane_multiple (2x-tiling-4)
[236.730277] Starting subtest: 2x-tiling-4
[236.734713] Subtest 2x-tiling-4: SKIP (0.000s)
[236.804339] [075/154] (784s left) perf_pmu (busy-start)
[236.840605] Starting subtest: busy-start
[236.842923] Starting dynamic subtest: rcs0
[239.395194] Dynamic subtest rcs0: SUCCESS (2.553s)
[239.405869] Starting dynamic subtest: bcs0
[241.945309] Dynamic subtest bcs0: SUCCESS (2.549s)
[241.958086] Starting dynamic subtest: vcs0
[245.321772] Dynamic subtest vcs0: SUCCESS (3.373s)
[245.334341] Starting dynamic subtest: vcs1
[249.289959] Dynamic subtest vcs1: SUCCESS (3.966s)
[249.302607] Starting dynamic subtest: vecs0
[253.321387] Dynamic subtest vecs0: SUCCESS (4.028s)
[253.335194] Starting dynamic subtest: ccs0
[255.869681] Dynamic subtest ccs0: SUCCESS (2.548s)
[255.872493] Subtest busy-start: SUCCESS (19.029s)
[255.976363] [076/154] (765s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[256.093496] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[256.097526] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[256.171675] [077/154] (765s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[256.275727] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[256.280089] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[256.381253] [078/154] (764s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[256.496132] Starting subtest: psr-rgb101010-draw-blt
[263.830239] Subtest psr-rgb101010-draw-blt: SUCCESS (7.340s)
[263.956803] [079/154] (757s left) i915_pm_rps (thresholds-idle-park)
[264.011944] Starting subtest: thresholds-idle-park
[264.016283] Subtest thresholds-idle-park: SKIP (0.000s)
[264.110648] [080/154] (757s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[264.205489] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[265.296173] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.090s)
[265.418149] [081/154] (756s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[265.470042] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[265.539100] [082/154] (755s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[265.639695] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[265.641699] Starting dynamic subtest: pipe-A-eDP-1
[265.739140] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[265.748959] Starting dynamic subtest: pipe-B-eDP-1
[266.904520] Dynamic subtest pipe-B-eDP-1: SKIP (1.162s)
[266.909273] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.265s)
[268.078790] [083/154] (753s left) gem_create (create-ext-placement-each)
[268.250788] Starting subtest: create-ext-placement-each
[268.253114] Subtest create-ext-placement-each: SUCCESS (0.000s)
[268.349493] [084/154] (753s left) gem_mmap_wc (fault-concurrent)
[268.416903] Subtest fault-concurrent: SKIP (0.000s)
[268.486389] [085/154] (753s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[268.580398] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[268.584549] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[268.672831] [086/154] (753s left) syncobj_timeline (host-signal-points)
[268.726616] Starting subtest: host-signal-points
[268.731873] Subtest host-signal-points: SUCCESS (0.005s)
[268.854574] [087/154] (752s left) gem_exec_reloc (basic-wc-gtt)
[268.913310] Subtest basic-wc-gtt: SKIP (0.000s)
[268.983281] [088/154] (752s left) kms_flip (flip-vs-expired-vblank-interruptible)
[269.076352] Starting subtest: flip-vs-expired-vblank-interruptible
[269.078670] Starting dynamic subtest: A-eDP1
[277.785901] Dynamic subtest A-eDP1: SUCCESS (8.708s)
[277.796131] Starting dynamic subtest: B-eDP1
[286.426690] Dynamic subtest B-eDP1: SUCCESS (8.639s)
[286.441763] Starting dynamic subtest: C-eDP1
[295.043123] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[295.053326] Starting dynamic subtest: D-eDP1
[303.671222] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[303.677562] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.598s)
[304.841825] [089/154] (716s left) kms_busy (extended-pageflip-hang-newfb)
[304.949142] Starting subtest: extended-pageflip-hang-newfb
[304.951547] Starting dynamic subtest: pipe-A
[331.115289] Dynamic subtest pipe-A: SUCCESS (26.163s)
[331.125130] Starting dynamic subtest: pipe-D
[346.078333] Dynamic subtest pipe-D: SUCCESS (14.960s)
[346.080674] Subtest extended-pageflip-hang-newfb: SUCCESS (41.128s)
[346.899264] [090/154] (674s left) gem_close_race (basic-threads)
[346.978329] Starting subtest: basic-threads
[348.341786] Subtest basic-threads: SUCCESS (1.363s)
[348.539555] [091/154] (673s left) kms_addfb_basic (basic-y-tiled-legacy)
[348.606858] Starting subtest: basic-y-tiled-legacy
[348.611591] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[348.753662] [092/154] (673s left) kms_sequence (get-forked)
[348.843717] Starting subtest: get-forked
[348.845963] Starting dynamic subtest: pipe-A-eDP-1
[350.719471] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[350.729355] Starting dynamic subtest: pipe-B-eDP-1
[353.254081] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.535s)
[353.264814] Starting dynamic subtest: pipe-C-eDP-1
[355.758659] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.503s)
[355.769339] Starting dynamic subtest: pipe-D-eDP-1
[358.285566] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.526s)
[358.288098] Subtest get-forked: SUCCESS (9.445s)
[359.125970] [093/154] (662s left) vgem_basic (dmabuf-export)
[359.166665] Starting subtest: dmabuf-export
[359.207086] Subtest dmabuf-export: SUCCESS (0.042s)
[359.303843] [094/154] (662s left) kms_flip (wf_vblank-ts-check)
[359.387485] Starting subtest: wf_vblank-ts-check
[359.390603] Starting dynamic subtest: A-eDP1
[368.382707] Dynamic subtest A-eDP1: SUCCESS (8.983s)
[368.395443] Starting dynamic subtest: B-eDP1
[377.298528] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[377.309758] Starting dynamic subtest: C-eDP1
[386.213814] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[386.224951] Starting dynamic subtest: D-eDP1
[395.155880] Dynamic subtest D-eDP1: SUCCESS (8.941s)
[395.158118] Subtest wf_vblank-ts-check: SUCCESS (35.769s)
[396.392329] [095/154] (625s left) api_intel_bb (blit-noreloc-purge-cache)
[396.465064] Starting subtest: blit-noreloc-purge-cache
[396.472076] Subtest blit-noreloc-purge-cache: SUCCESS (0.009s)
[396.605031] [096/154] (625s left) kms_frontbuffer_tracking (psrhdr-modesetfrombusy)
[396.698160] Starting subtest: psrhdr-modesetfrombusy
[396.702414] Subtest psrhdr-modesetfrombusy: SKIP (0.000s)
[396.785233] [097/154] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[396.879807] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[396.883819] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[396.978876] [098/154] (625s left) gem_exec_whisper (basic-forked-all)
[397.035398] Starting subtest: basic-forked-all
[410.560962] Subtest basic-forked-all: SUCCESS (13.523s)
[410.749591] [099/154] (611s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[410.845135] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[410.849143] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[410.938860] [100/154] (611s left) syncobj_timeline (transfer-timeline-point)
[411.005438] Starting subtest: transfer-timeline-point
[411.007800] Subtest transfer-timeline-point: SUCCESS (0.000s)
[411.127533] [101/154] (611s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[411.229902] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[412.076058] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.848s)
[412.264820] [102/154] (610s left) syncobj_wait (invalid-single-wait-unsubmitted)
[412.332096] Starting subtest: invalid-single-wait-unsubmitted
[412.334429] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[412.427917] [103/154] (610s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[412.517488] Starting subtest: x-tiled-64bpp-rotate-180
[414.106814] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.589s)
[414.273453] [104/154] (608s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[414.369819] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[418.097234] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.733s)
[419.279032] [105/154] (603s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[419.378306] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[419.382907] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[419.499731] [106/154] (603s left) core_setmaster (master-drop-set-root)
[419.556192] Starting subtest: master-drop-set-root
[419.584580] Subtest master-drop-set-root: SUCCESS (0.024s)
[419.631852] [107/154] (602s left) i915_hangman (gt-engine-error)
[419.683071] Starting subtest: gt-engine-error
[419.685445] Starting dynamic subtest: rcs0
[421.288454] Dynamic subtest rcs0: SUCCESS (1.604s)
[421.301987] Starting dynamic subtest: bcs0
[423.271859] Dynamic subtest bcs0: SUCCESS (1.980s)
[423.284828] Starting dynamic subtest: vcs0
[425.255616] Dynamic subtest vcs0: SUCCESS (1.981s)
[425.269126] Starting dynamic subtest: vcs1
[427.303510] Dynamic subtest vcs1: SUCCESS (2.045s)
[427.315958] Starting dynamic subtest: vecs0
[429.287669] Dynamic subtest vecs0: SUCCESS (1.981s)
[429.306586] Starting dynamic subtest: ccs0
[431.271822] Dynamic subtest ccs0: SUCCESS (1.981s)
[431.274814] Subtest gt-engine-error: SUCCESS (11.590s)
[431.357461] [108/154] (591s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-onoff)
[431.471080] Starting subtest: psrhdr-1p-primscrn-cur-indfb-onoff
[431.475676] Subtest psrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[431.587502] [109/154] (591s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[431.700153] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[431.704131] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[431.810106] [110/154] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[431.920172] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[431.924133] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[432.031955] [111/154] (590s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[432.136924] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[432.141297] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[432.240846] [112/154] (590s left) kms_vblank (ts-continuation-suspend)
[432.340570] Starting subtest: ts-continuation-suspend
[432.342499] Starting dynamic subtest: pipe-A-eDP-1
[448.364549] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.378s)
[448.381548] Starting dynamic subtest: pipe-D-eDP-1
[465.332600] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.162s)
[465.335014] Subtest ts-continuation-suspend: SUCCESS (4.544s)
[466.184884] [113/154] (556s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[466.289478] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[466.293941] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[466.378849] [114/154] (556s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[466.475843] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[466.480341] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[466.598246] [115/154] (556s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[466.720921] Starting subtest: cursorB-vs-flipB-atomic-transitions
[466.725509] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[466.881084] [116/154] (556s left) kms_psr (psr2-dpms)
[466.970416] Starting subtest: psr2-dpms
[466.972738] Starting dynamic subtest: eDP-1
[469.857313] Dynamic subtest eDP-1: SUCCESS (2.853s)
[469.860073] Subtest psr2-dpms: SUCCESS (2.854s)
[470.755160] [117/154] (552s left) gem_mmap_offset (bad-object)
[470.816794] Starting subtest: bad-object
[470.818863] Subtest bad-object: SUCCESS (0.001s)
[470.932660] [118/154] (552s left) gem_exec_params (no-vebox)
[470.989030] Starting subtest: no-vebox
[470.991474] Subtest no-vebox: SUCCESS (0.002s)
[472.791343] [119/154] (550s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[472.855397] Starting subtest: invalid-single-wait-all-unsubmitted
[472.857412] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[472.958486] [120/154] (550s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[473.012207] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[473.073299] [121/154] (550s left) perf (blocking)
[473.206910] Starting subtest: blocking
[473.209162] Starting dynamic subtest: 0-rcs0
[483.224435] Dynamic subtest 0-rcs0: SUCCESS (9.980s)
[483.235619] Starting dynamic subtest: 1-vcs0
[493.261845] Dynamic subtest 1-vcs0: SUCCESS (10.022s)
[493.264476] Subtest blocking: SUCCESS (20.005s)
[493.315187] [122/154] (529s left) kms_cursor_legacy (forked-move)
[493.447447] Starting subtest: forked-move
[493.450449] Starting dynamic subtest: pipe-A
[498.917483] Dynamic subtest pipe-A: SUCCESS (5.468s)
[498.934599] Starting dynamic subtest: pipe-B
[504.391624] Dynamic subtest pipe-B: SUCCESS (5.473s)
[504.406848] Starting dynamic subtest: pipe-C
[509.869054] Dynamic subtest pipe-C: SUCCESS (5.476s)
[509.882193] Starting dynamic subtest: pipe-D
[515.350397] Dynamic subtest pipe-D: SUCCESS (5.478s)
[515.361665] Starting dynamic subtest: all-pipes
[520.856504] Dynamic subtest all-pipes: SUCCESS (5.503s)
[520.858862] Subtest forked-move: SUCCESS (27.410s)
[521.009417] [123/154] (502s left) kms_psr (fbc-pr-cursor-plane-onoff)
[521.106242] Starting subtest: fbc-pr-cursor-plane-onoff
[521.111564] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[521.183743] [124/154] (502s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[521.287475] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[525.654675] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.373s)
[526.819202] [125/154] (496s left) gem_exec_balancer (semaphore)
[526.884212] Starting subtest: semaphore
[528.689401] Subtest semaphore: SUCCESS (1.803s)
[529.035269] [126/154] (494s left) syncobj_timeline (wait-zero-handles)
[529.096152] Starting subtest: wait-zero-handles
[529.098666] Subtest wait-zero-handles: SUCCESS (0.000s)
[529.235767] [127/154] (494s left) kms_psr (psr-sprite-blt)
[529.328092] Starting subtest: psr-sprite-blt
[529.330384] Starting dynamic subtest: eDP-1
[531.093292] Dynamic subtest eDP-1: SUCCESS (1.765s)
[531.095737] Subtest psr-sprite-blt: SUCCESS (1.766s)
[531.956992] [128/154] (491s left) gem_ctx_param (get-priority-new-ctx)
[532.007221] Starting subtest: get-priority-new-ctx
[532.009750] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[532.105850] [129/154] (491s left) kms_joiner (basic-big-joiner)
[532.214915] Starting subtest: basic-big-joiner
[532.219031] Subtest basic-big-joiner: SKIP (0.000s)
[532.287161] [130/154] (491s left) kms_cursor_crc (cursor-offscreen-64x21)
[532.477159] Starting subtest: cursor-offscreen-64x21
[532.527034] Subtest cursor-offscreen-64x21: SKIP (0.044s)
[532.764614] [131/154] (490s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[532.856300] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[532.860692] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[532.960446] [132/154] (490s left) gen7_exec_parse (batch-without-end)
[533.016066] Subtest batch-without-end: SKIP (0.000s)
[533.081668] [133/154] (490s left) kms_content_protection (atomic)
[533.223289] Starting subtest: atomic
[533.228196] Subtest atomic: SKIP (0.000s)
[533.360527] [134/154] (490s left) gem_pwrite (basic-random)
[533.414828] Subtest basic-random: SKIP (0.000s)
[533.474454] [135/154] (490s left) gem_exec_schedule (preempt-queue)
[533.542054] Subtest preempt-queue: SKIP (0.000s)
[533.847201] [136/154] (490s left) gem_exec_schedule (u-submit-early-slice)
[533.922288] Starting subtest: u-submit-early-slice
[533.924730] Starting dynamic subtest: rcs0
[533.961311] Dynamic subtest rcs0: SUCCESS (0.041s)
[533.975498] Starting dynamic subtest: bcs0
[534.004946] Dynamic subtest bcs0: SUCCESS (0.042s)
[534.016251] Starting dynamic subtest: vcs0
[534.044724] Dynamic subtest vcs0: SUCCESS (0.039s)
[534.055728] Starting dynamic subtest: vcs1
[534.094973] Dynamic subtest vcs1: SUCCESS (0.049s)
[534.109125] Starting dynamic subtest: vecs0
[534.131528] Dynamic subtest vecs0: SUCCESS (0.036s)
[534.142096] Starting dynamic subtest: ccs0
[534.167631] Dynamic subtest ccs0: SUCCESS (0.035s)
[534.169870] Subtest u-submit-early-slice: SUCCESS (0.249s)
[535.853558] [137/154] (488s left) gem_exec_whisper (basic-queues-forked)
[535.913832] Starting subtest: basic-queues-forked
[558.884190] Subtest basic-queues-forked: SUCCESS (22.959s)
[559.068275] [138/154] (464s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[559.168289] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[565.747818] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.587s)
[565.862511] [139/154] (458s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[565.966081] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[565.970195] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[566.072280] [140/154] (457s left) kms_psr (psr2-primary-render)
[566.173202] Starting subtest: psr2-primary-render
[566.175544] Starting dynamic subtest: eDP-1
[567.886787] Dynamic subtest eDP-1: SUCCESS (1.714s)
[567.889146] Subtest psr2-primary-render: SUCCESS (1.715s)
[568.763265] [141/154] (455s left) syncobj_timeline (invalid-query-one-illegal-handle)
[568.813374] Starting subtest: invalid-query-one-illegal-handle
[568.815682] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[568.929426] [142/154] (455s left) gem_exec_reloc (basic-cpu-wc-active)
[568.983204] Subtest basic-cpu-wc-active: SKIP (0.000s)
[569.073419] [143/154] (455s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[569.172053] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[569.176193] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[569.270228] [144/154] (454s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-blt)
[569.371511] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-blt
[569.375895] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[569.468965] [145/154] (454s left) syncobj_wait (wait-for-submit-snapshot)
[569.525689] Starting subtest: wait-for-submit-snapshot
[569.606098] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[569.684612] [146/154] (454s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[569.777497] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[569.779399] Starting dynamic subtest: pipe-A-eDP-1
[569.798226] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[569.808983] Starting dynamic subtest: pipe-B-eDP-1
[569.826538] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[569.836558] Starting dynamic subtest: pipe-C-eDP-1
[569.853521] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[569.863433] Starting dynamic subtest: pipe-D-eDP-1
[569.880996] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[569.884252] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[572.016961] [147/154] (452s left) kms_pipe_crc_basic (hang-read-crc)
[572.112592] Starting subtest: hang-read-crc
[572.114476] Starting dynamic subtest: pipe-A-eDP-1
[574.203590] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.091s)
[574.216682] Starting dynamic subtest: pipe-B-eDP-1
[577.059448] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.857s)
[577.071748] Starting dynamic subtest: pipe-C-eDP-1
[579.774009] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.710s)
[579.785871] Starting dynamic subtest: pipe-D-eDP-1
[582.431777] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.658s)
[582.433748] Subtest hang-read-crc: SUCCESS (10.321s)
[583.276154] [148/154] (441s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[583.374307] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[583.378962] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[583.482736] [149/154] (440s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[583.537705] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[583.638086] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[583.726695] [150/154] (440s left) kms_flip (2x-modeset-vs-vblank-race)
[583.828280] Starting subtest: 2x-modeset-vs-vblank-race
[583.838017] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[583.954169] [151/154] (440s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[584.014536] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[584.018889] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[584.211602] [152/154] (440s left) gen9_exec_parse (unaligned-access)
[584.278333] Subtest unaligned-access: SKIP (0.000s)
[584.343387] [153/154] (440s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[584.434393] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[584.436698] Starting dynamic subtest: pipe-A-default-mode
[587.214413] Dynamic subtest pipe-A-default-mode: SUCCESS (2.781s)
[587.216882] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.783s)
[588.039369] [154/154] (436s left) kms_atomic_transition (plane-all-transition-nonblocking)
[588.140793] Starting subtest: plane-all-transition-nonblocking
[588.143196] Starting dynamic subtest: pipe-A-eDP-1
[590.639785] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s)
[590.950125] Starting dynamic subtest: pipe-B-eDP-1
[594.166074] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.229s)
[594.464890] Subtest plane-all-transition-nonblocking: SUCCESS (6.323s)
[595.287054] 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.