[60.448687] Initializing watchdogs
[60.448730]   /dev/watchdog0
[60.463184] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[60.467096] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.469077] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.472359] [001/131] (960s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[60.592855] Starting subtest: cursorB-vs-flipA-legacy
[60.597382] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[60.744079] [002/131] (960s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[60.800675] Starting subtest: wait-all-for-submit-delayed-submit
[60.904690] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[60.987182] [003/131] (960s left) core_debugfs (read-all-entries)
[61.032246] Starting subtest: read-all-entries
[61.114433] Subtest read-all-entries: SUCCESS (0.083s)
[61.190926] [004/131] (959s left) kms_big_fb (linear-64bpp-rotate-0)
[61.275272] Starting subtest: linear-64bpp-rotate-0
[62.790844] Subtest linear-64bpp-rotate-0: SUCCESS (1.523s)
[62.977922] [005/131] (958s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[63.054320] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[63.125357] [006/131] (958s left) gem_exec_schedule (submit-golden-slice)
[63.190855] Starting subtest: submit-golden-slice
[63.193207] Starting dynamic subtest: rcs0
[63.224712] Dynamic subtest rcs0: SUCCESS (0.034s)
[63.232885] Starting dynamic subtest: bcs0
[63.252673] Dynamic subtest bcs0: SUCCESS (0.028s)
[63.261213] Starting dynamic subtest: vcs0
[63.283749] Dynamic subtest vcs0: SUCCESS (0.031s)
[63.291206] Starting dynamic subtest: vcs1
[63.313670] Dynamic subtest vcs1: SUCCESS (0.030s)
[63.321235] Starting dynamic subtest: vecs0
[63.342339] Dynamic subtest vecs0: SUCCESS (0.029s)
[63.349903] Starting dynamic subtest: ccs0
[63.371095] Dynamic subtest ccs0: SUCCESS (0.029s)
[63.373373] Subtest submit-golden-slice: SUCCESS (0.181s)
[65.281415] [007/131] (955s left) perf (low-oa-exponent-permissions)
[65.406510] Starting subtest: low-oa-exponent-permissions
[65.444189] Subtest low-oa-exponent-permissions: SUCCESS (0.038s)
[65.489091] [008/131] (955s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[65.567652] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[65.569980] Starting dynamic subtest: pipe-A-eDP-1
[71.462245] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.909s)
[71.471803] Starting dynamic subtest: pipe-B-eDP-1
[78.099804] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.641s)
[78.102133] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.551s)
[78.972159] [009/131] (942s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[79.076089] Starting subtest: yf-tiled-16bpp-rotate-0
[79.080183] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[79.159379] [010/131] (942s left) kms_cursor_legacy (torture-move)
[79.254743] Starting subtest: torture-move
[79.257029] Starting dynamic subtest: pipe-A
[85.042911] Dynamic subtest pipe-A: SUCCESS (5.787s)
[85.054050] Starting dynamic subtest: pipe-B
[91.564113] Dynamic subtest pipe-B: SUCCESS (6.524s)
[91.574492] Starting dynamic subtest: pipe-C
[97.462902] Dynamic subtest pipe-C: SUCCESS (5.901s)
[97.474726] Starting dynamic subtest: pipe-D
[103.949499] Dynamic subtest pipe-D: SUCCESS (6.488s)
[103.965391] Starting dynamic subtest: all-pipes
[110.382622] Dynamic subtest all-pipes: SUCCESS (6.433s)
[110.384993] Subtest torture-move: SUCCESS (31.138s)
[110.556856] [011/131] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[110.658263] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[115.074230] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.420s)
[116.260795] [012/131] (905s left) syncobj_wait (reset-unsignaled)
[116.320817] Starting subtest: reset-unsignaled
[116.323201] Subtest reset-unsignaled: SUCCESS (0.000s)
[116.411925] [013/131] (905s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[116.490280] Starting subtest: fbc-psr2-cursor-plane-onoff
[116.492539] Starting dynamic subtest: eDP-1
[116.496711] Dynamic subtest eDP-1: SKIP (0.000s)
[116.500840] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[116.559260] [014/131] (904s left) kms_cursor_crc (cursor-sliding-64x64)
[116.713801] Starting subtest: cursor-sliding-64x64
[116.716352] Starting dynamic subtest: pipe-A-eDP-1
[119.950454] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.234s)
[119.984591] Starting dynamic subtest: pipe-D-eDP-1
[123.836722] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.859s)
[123.839191] Subtest cursor-sliding-64x64: SUCCESS (7.125s)
[124.702426] [015/131] (896s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[124.801525] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[125.751185] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.947s)
[126.631618] [016/131] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[126.710480] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[133.747056] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.041s)
[133.855911] [017/131] (887s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[133.948544] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[133.952588] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[134.062262] [018/131] (887s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[134.114932] Subtest writes-after-reads-snoop: SKIP (0.000s)
[134.176776] [019/131] (887s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[134.251876] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[134.256403] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[135.382648] [020/131] (886s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[135.433154] Starting subtest: etime-single-wait-available-unsubmitted
[135.538438] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s)
[135.609662] [021/131] (886s left) gem_reg_read (timestamp-monotonic)
[135.656087] Starting subtest: timestamp-monotonic
[139.957319] Subtest timestamp-monotonic: SUCCESS (4.301s)
[140.029088] [022/131] (881s left) gem_wait (write-busy)
[140.093534] Starting subtest: write-busy
[140.095950] Starting dynamic subtest: all-engines
[140.717739] Dynamic subtest all-engines: SUCCESS (0.624s)
[140.732276] Starting dynamic subtest: rcs0
[141.269267] Dynamic subtest rcs0: SUCCESS (0.551s)
[141.285073] Starting dynamic subtest: bcs0
[141.818968] Dynamic subtest bcs0: SUCCESS (0.548s)
[141.832993] Starting dynamic subtest: vcs0
[143.230416] Dynamic subtest vcs0: SUCCESS (1.409s)
[143.245242] Starting dynamic subtest: vcs1
[145.213658] Dynamic subtest vcs1: SUCCESS (1.981s)
[145.229547] Starting dynamic subtest: vecs0
[147.197848] Dynamic subtest vecs0: SUCCESS (1.983s)
[147.213409] Starting dynamic subtest: ccs0
[147.746046] Dynamic subtest ccs0: SUCCESS (0.549s)
[147.748517] Subtest write-busy: SUCCESS (7.654s)
[147.942154] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[147.945382] [023/131] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[148.036347] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[148.040301] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[148.124391] [024/131] (873s left) gem_exec_fence (syncobj-import)
[148.542818] Starting subtest: syncobj-import
[148.548161] Subtest syncobj-import: SUCCESS (0.004s)
[150.291039] [025/131] (871s left) gem_exec_schedule (implicit-boths)
[150.366694] Starting subtest: implicit-boths
[150.368620] Starting dynamic subtest: rcs0
[150.466262] Dynamic subtest rcs0: SUCCESS (0.109s)
[150.478628] Starting dynamic subtest: vcs0
[150.557950] Dynamic subtest vcs0: SUCCESS (0.089s)
[150.569244] Starting dynamic subtest: vcs1
[150.662571] Dynamic subtest vcs1: SUCCESS (0.106s)
[150.671464] Starting dynamic subtest: vecs0
[150.757189] Dynamic subtest vecs0: SUCCESS (0.094s)
[150.768778] Starting dynamic subtest: ccs0
[150.892584] Dynamic subtest ccs0: SUCCESS (0.133s)
[150.895400] Subtest implicit-boths: SUCCESS (0.536s)
[152.334636] [026/131] (869s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[152.421784] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[156.111052] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.694s)
[157.265296] [027/131] (864s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[157.436643] Starting subtest: cursor-rapid-movement-64x21
[157.479659] Subtest cursor-rapid-movement-64x21: SKIP (0.039s)
[157.705950] [028/131] (864s left) gem_mmap_gtt (cpuset-medium-copy)
[157.756781] Subtest cpuset-medium-copy: SKIP (0.000s)
[157.813279] [029/131] (864s left) kms_dp_link_training (uhbr-sst)
[157.879729] Starting subtest: uhbr-sst
[157.888245] Subtest uhbr-sst: SKIP (0.000s)
[157.954187] [030/131] (864s left) i915_drm_fdinfo (memory-info-purgeable)
[157.997725] Starting subtest: memory-info-purgeable
[157.999957] Starting dynamic subtest: smem0
[160.719126] Dynamic subtest smem0: SUCCESS (2.721s)
[160.721225] Subtest memory-info-purgeable: SUCCESS (2.722s)
[160.793822] [031/131] (861s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[160.876430] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[160.878431] Starting dynamic subtest: pipe-A
[160.895391] Dynamic subtest pipe-A: SKIP (0.017s)
[160.904222] Starting dynamic subtest: pipe-B
[160.925397] Dynamic subtest pipe-B: SKIP (0.030s)
[160.933351] Starting dynamic subtest: pipe-C
[160.961440] Dynamic subtest pipe-C: SKIP (0.034s)
[160.969672] Starting dynamic subtest: pipe-D
[160.990517] Dynamic subtest pipe-D: SKIP (0.029s)
[160.993958] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.112s)
[161.080759] [032/131] (861s left) gem_exec_nop (basic-sequential)
[161.149048] Starting subtest: basic-sequential
[175.757243] Subtest basic-sequential: SUCCESS (14.593s)
[175.981220] [033/131] (846s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[176.066937] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[176.069250] Starting dynamic subtest: pipe-A-eDP-1
[176.093689] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[176.103948] Starting dynamic subtest: pipe-B-eDP-1
[176.125892] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[176.134322] Starting dynamic subtest: pipe-C-eDP-1
[176.156154] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[176.164430] Starting dynamic subtest: pipe-D-eDP-1
[176.186661] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[176.190768] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[178.226300] [034/131] (844s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[178.315426] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[178.320034] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[178.412945] [035/131] (843s left) gem_caching (writes)
[178.483442] Subtest writes: SKIP (0.000s)
[178.560430] [036/131] (843s left) kms_chamelium_hpd (dp-hpd-storm)
[178.931665] Subtest dp-hpd-storm: SKIP (0.000s)
[179.746177] [037/131] (842s left) gem_ctx_param (set-priority-not-supported)
[179.804893] Starting subtest: set-priority-not-supported
[179.809757] Subtest set-priority-not-supported: SKIP (0.000s)
[179.891489] [038/131] (842s left) syncobj_wait (invalid-signal-bad-pad)
[179.945048] Starting subtest: invalid-signal-bad-pad
[179.947299] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[180.038497] [039/131] (842s left) kms_addfb_basic (tile-pitch-mismatch)
[180.091993] Starting subtest: tile-pitch-mismatch
[180.096483] Subtest tile-pitch-mismatch: SKIP (0.000s)
[180.207460] [040/131] (842s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[180.274627] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[180.278875] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[180.348599] [041/131] (842s left) gem_ctx_exec (basic-invalid-context)
[180.399587] Starting subtest: basic-invalid-context
[180.403799] Subtest basic-invalid-context: SUCCESS (0.005s)
[180.511994] [042/131] (842s left) api_intel_allocator (two-level-inception-interruptible)
[180.571976] Starting subtest: two-level-inception-interruptible
[186.028580] Subtest two-level-inception-interruptible: SUCCESS (5.403s)
[186.119494] [043/131] (836s left) kms_psr (pr-cursor-render)
[186.205155] Starting subtest: pr-cursor-render
[186.209534] Subtest pr-cursor-render: SKIP (0.000s)
[186.278336] [044/131] (836s left) syncobj_timeline (invalid-signal-bad-pad)
[186.342293] Starting subtest: invalid-signal-bad-pad
[186.344337] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[186.461827] [045/131] (836s left) gem_ctx_param (basic-default)
[186.517879] Starting subtest: basic-default
[186.520383] Subtest basic-default: SUCCESS (0.000s)
[186.593687] [046/131] (836s left) gem_tiled_swapping (non-threaded)
[186.654299] Subtest non-threaded: SKIP (0.000s)
[186.719959] [047/131] (836s left) kms_atomic (test-only)
[186.801438] Starting subtest: test-only
[186.852224] Starting dynamic subtest: pipe-A-eDP-1
[189.404966] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.554s)
[189.407644] Subtest test-only: SUCCESS (2.604s)
[190.271088] [048/131] (832s left) kms_hdr (invalid-metadata-sizes)
[190.345437] Starting subtest: invalid-metadata-sizes
[190.352510] Subtest invalid-metadata-sizes: SKIP (0.000s)
[190.418345] [049/131] (832s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[190.478430] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[190.480907] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[190.607068] [050/131] (832s left) kms_vblank (ts-continuation-modeset-hang)
[190.683939] Starting subtest: ts-continuation-modeset-hang
[190.685931] Starting dynamic subtest: pipe-A-eDP-1
[216.966747] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.283s)
[216.979920] Starting dynamic subtest: pipe-D-eDP-1
[232.000198] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.029s)
[232.002182] Subtest ts-continuation-modeset-hang: SUCCESS (41.317s)
[232.811647] [051/131] (790s left) kms_psr (psr-primary-mmap-gtt)
[232.886434] Starting subtest: psr-primary-mmap-gtt
[232.888883] Starting dynamic subtest: eDP-1
[234.300723] Dynamic subtest eDP-1: SKIP (1.414s)
[234.305577] Subtest psr-primary-mmap-gtt: SKIP (1.415s)
[234.437774] [052/131] (788s left) gem_render_copy (yf-tiled-to-vebox-linear)
[234.487678] Starting subtest: yf-tiled-to-vebox-linear
[234.492021] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[234.665084] [053/131] (788s left) kms_content_protection (dp-mst-type-0-hdcp14)
[234.778662] Starting subtest: dp-mst-type-0-hdcp14
[234.783290] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[234.900415] [054/131] (788s left) gem_softpin (reverse)
[234.963841] Starting subtest: reverse
[234.968928] Subtest reverse: SUCCESS (0.005s)
[235.106625] [055/131] (788s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[235.185599] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[235.187698] Starting dynamic subtest: pipe-A-default-mode
[237.860137] Dynamic subtest pipe-A-default-mode: SUCCESS (2.673s)
[237.862359] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.675s)
[238.721517] [056/131] (784s left) kms_invalid_mode (bad-vtotal)
[238.799245] Starting subtest: bad-vtotal
[238.801358] Starting dynamic subtest: pipe-A-eDP-1
[239.093877] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[239.103680] Starting dynamic subtest: pipe-B-eDP-1
[239.105686] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[239.113343] Starting dynamic subtest: pipe-C-eDP-1
[239.115650] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[239.123567] Starting dynamic subtest: pipe-D-eDP-1
[239.125421] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[239.127307] Subtest bad-vtotal: SUCCESS (0.303s)
[239.972727] [057/131] (783s left) perf_pmu (init-busy)
[240.013831] Starting subtest: init-busy
[240.016254] Starting dynamic subtest: rcs0
[240.018702] Dynamic subtest rcs0: SUCCESS (0.001s)
[240.029428] Starting dynamic subtest: bcs0
[240.031340] Dynamic subtest bcs0: SUCCESS (0.000s)
[240.039169] Starting dynamic subtest: vcs0
[240.041075] Dynamic subtest vcs0: SUCCESS (0.000s)
[240.048774] Starting dynamic subtest: vcs1
[240.050701] Dynamic subtest vcs1: SUCCESS (0.000s)
[240.058253] Starting dynamic subtest: vecs0
[240.060116] Dynamic subtest vecs0: SUCCESS (0.000s)
[240.067638] Starting dynamic subtest: ccs0
[240.069545] Dynamic subtest ccs0: SUCCESS (0.000s)
[240.071464] Subtest init-busy: SUCCESS (0.006s)
[240.131536] [058/131] (783s left) gem_ppgtt (shrink-vs-evict-any)
[240.186359] Starting subtest: shrink-vs-evict-any
[248.269311] Subtest shrink-vs-evict-any: SUCCESS (8.060s)
[248.347769] [059/131] (774s left) gem_softpin (invalid)
[248.414895] Starting subtest: invalid
[248.423730] Subtest invalid: SUCCESS (0.009s)
[248.577325] [060/131] (774s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[248.652377] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[248.656603] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[248.716602] [061/131] (774s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[248.791178] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[248.793374] Starting dynamic subtest: pipe-A-eDP-1
[248.816161] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[248.827039] Starting dynamic subtest: pipe-B-eDP-1
[248.848606] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[248.856965] Starting dynamic subtest: pipe-C-eDP-1
[248.878494] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[248.886675] Starting dynamic subtest: pipe-D-eDP-1
[248.908265] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[248.912246] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[251.054915] [062/131] (772s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[251.127191] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[251.131593] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[251.215743] [063/131] (772s left) prime_busy (after-wait)
[251.278307] Starting subtest: after-wait
[251.282868] Starting dynamic subtest: rcs0
[251.309114] Dynamic subtest rcs0: SUCCESS (0.028s)
[251.318214] Starting dynamic subtest: bcs0
[251.348409] Dynamic subtest bcs0: SUCCESS (0.039s)
[251.356992] Starting dynamic subtest: vcs0
[251.389676] Dynamic subtest vcs0: SUCCESS (0.040s)
[251.398172] Starting dynamic subtest: vcs1
[251.430966] Dynamic subtest vcs1: SUCCESS (0.040s)
[251.439455] Starting dynamic subtest: vecs0
[251.471282] Dynamic subtest vecs0: SUCCESS (0.039s)
[251.479777] Starting dynamic subtest: ccs0
[251.510826] Dynamic subtest ccs0: SUCCESS (0.039s)
[251.619754] Subtest after-wait: SUCCESS (0.340s)
[251.693728] [064/131] (771s left) perf_pmu (all-busy-check-all)
[251.736071] Starting subtest: all-busy-check-all
[253.245993] Subtest all-busy-check-all: SUCCESS (1.512s)
[253.334499] [065/131] (770s left) gen9_exec_parse (bb-chained)
[253.390070] Subtest bb-chained: SKIP (0.000s)
[253.459442] [066/131] (770s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[253.549480] Starting subtest: flip-vs-cursor-crc-legacy
[254.196523] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.646s)
[255.074808] [067/131] (768s left) gem_exec_whisper (basic-queues)
[255.150280] Starting subtest: basic-queues
[260.223347] Subtest basic-queues: SUCCESS (5.073s)
[260.403174] [068/131] (763s left) kms_pm_dc (dc5-dpms)
[261.496707] Starting subtest: dc5-dpms
[263.543028] Subtest dc5-dpms: SUCCESS (2.045s)
[263.620270] [069/131] (760s left) gem_exec_flush (basic-uc-pro-default)
[263.673366] Starting subtest: basic-uc-pro-default
[269.143215] Subtest basic-uc-pro-default: SUCCESS (5.471s)
[269.335873] [070/131] (754s left) gem_exec_balancer (bonded-false-hang)
[269.605848] Starting subtest: bonded-false-hang
[269.610486] Subtest bonded-false-hang: SKIP (0.000s)
[269.739827] [071/131] (754s left) i915_suspend (sysfs-reader)
[269.798452] Starting subtest: sysfs-reader
[288.529515] Subtest sysfs-reader: SUCCESS (3.994s)
[288.605193] [072/131] (735s left) syncobj_wait (single-wait-signaled)
[288.678599] Starting subtest: single-wait-signaled
[288.680526] Subtest single-wait-signaled: SUCCESS (0.000s)
[288.773404] [073/131] (735s left) kms_setmode (invalid-clone-single-crtc-stealing)
[288.821330] Starting subtest: invalid-clone-single-crtc-stealing
[288.826695] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[288.925809] [074/131] (734s left) sw_sync (sync_busy)
[288.965030] Starting subtest: sync_busy
[288.966847] Subtest sync_busy: SUCCESS (0.002s)
[289.022345] [075/131] (734s left) gem_ctx_persistence (hang)
[289.076947] Starting subtest: hang
[289.080829] Subtest hang: SKIP (0.000s)
[289.173462] [076/131] (734s left) gem_exec_basic (basic)
[289.221397] Starting subtest: basic
[289.223385] Starting dynamic subtest: rcs0-smem
[289.225284] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[289.235600] Starting dynamic subtest: bcs0-smem
[289.237478] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[289.246090] Starting dynamic subtest: vcs0-smem
[289.247626] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[289.256221] Starting dynamic subtest: vcs1-smem
[289.257917] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[289.268575] Starting dynamic subtest: vecs0-smem
[289.270105] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[289.279351] Starting dynamic subtest: ccs0-smem
[289.280938] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[289.282426] Subtest basic: SUCCESS (0.016s)
[291.032351] [077/131] (732s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[291.108360] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[291.112709] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[291.211345] [078/131] (732s left) gem_lmem_swapping (massive-random)
[291.258879] Subtest massive-random: SKIP (0.000s)
[291.310729] [079/131] (732s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[291.389742] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[291.393799] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[291.457288] [080/131] (732s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[291.541463] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[291.545631] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[291.652933] [081/131] (732s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[291.727760] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[292.719217] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.000s)
[292.828942] [082/131] (731s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[292.902957] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[292.906399] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[293.026372] [083/131] (731s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[293.100459] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[299.656708] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.592s)
[299.796354] [084/131] (724s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[299.873143] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[299.875339] Starting dynamic subtest: pipe-A
[300.014833] Dynamic subtest pipe-A: SKIP (0.140s)
[300.025623] Starting dynamic subtest: pipe-B
[301.211501] Dynamic subtest pipe-B: SKIP (1.200s)
[301.222066] Starting dynamic subtest: pipe-C
[302.352406] Dynamic subtest pipe-C: SUCCESS (1.148s)
[302.363788] Starting dynamic subtest: pipe-D
[303.568237] Dynamic subtest pipe-D: SUCCESS (1.218s)
[303.570581] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.709s)
[304.757959] [085/131] (719s left) syncobj_wait (multi-wait-for-submit-signaled)
[304.835993] Starting subtest: multi-wait-for-submit-signaled
[304.838358] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[304.944794] [086/131] (719s left) kms_selftest (drm_cmdline_parser)
[304.985679] Starting subtest: drm_cmdline_parser
[305.017991] Starting dynamic subtest: drm_test_cmdline_force_d_only
[305.145158] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.127s)
[305.156911] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[305.247314] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.098s)
[305.261673] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[305.338079] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.095s)
[305.347985] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[305.429910] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.092s)
[305.441197] Starting dynamic subtest: drm_test_cmdline_force_e_only
[305.533038] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.104s)
[305.542599] Starting dynamic subtest: drm_test_cmdline_res
[305.640379] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.104s)
[305.651280] Starting dynamic subtest: drm_test_cmdline_res_vesa
[305.733217] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.090s)
[305.744093] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[305.813008] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.079s)
[305.823716] Starting dynamic subtest: drm_test_cmdline_res_rblank
[305.908519] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.095s)
[305.918971] Starting dynamic subtest: drm_test_cmdline_res_bpp
[306.010082] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.101s)
[306.019438] Starting dynamic subtest: drm_test_cmdline_res_refresh
[306.102764] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.094s)
[306.112296] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[306.198882] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.095s)
[306.207940] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[306.286130] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.087s)
[306.295165] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[306.382199] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.093s)
[306.392828] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[306.477613] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.095s)
[306.486859] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[306.573226] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.095s)
[306.583658] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[306.663345] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.089s)
[306.674253] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[306.745208] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.083s)
[306.756059] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[306.837279] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.090s)
[306.848170] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[306.938273] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.099s)
[306.947333] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[307.032204] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.093s)
[307.043231] Starting dynamic subtest: drm_test_cmdline_name
[307.133162] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.098s)
[307.143812] Starting dynamic subtest: drm_test_cmdline_name_bpp
[307.231410] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.098s)
[307.241954] Starting dynamic subtest: drm_test_cmdline_name_option
[307.328411] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.096s)
[307.338807] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[307.420535] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.090s)
[307.429743] Starting dynamic subtest: drm_test_cmdline_rotate_0
[307.506579] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.084s)
[307.515452] Starting dynamic subtest: drm_test_cmdline_rotate_90
[307.614204] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.107s)
[307.623624] Starting dynamic subtest: drm_test_cmdline_rotate_180
[307.702193] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.088s)
[307.712961] Starting dynamic subtest: drm_test_cmdline_rotate_270
[307.802249] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.097s)
[307.813692] Starting dynamic subtest: drm_test_cmdline_hmirror
[307.890510] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.088s)
[307.901633] Starting dynamic subtest: drm_test_cmdline_vmirror
[307.980866] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.089s)
[307.991919] Starting dynamic subtest: drm_test_cmdline_margin_options
[308.081053] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.100s)
[308.090195] Starting dynamic subtest: drm_test_cmdline_multiple_options
[308.184534] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.102s)
[308.195327] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[308.263887] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.078s)
[308.273983] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[308.368000] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.103s)
[308.378420] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[308.472049] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.104s)
[308.482233] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[308.573020] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.100s)
[308.583636] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[308.671037] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.098s)
[308.681939] Starting dynamic subtest: drm_test_cmdline_invalid
[308.773386] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.102s)
[308.782471] Starting dynamic subtest: drm_test_cmdline_tv_options
[308.886332] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.109s)
[308.888010] Subtest drm_cmdline_parser: SUCCESS (3.907s)
[309.040754] [087/131] (715s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[309.129180] Starting subtest: psr-rgb565-draw-blt
[316.199424] Subtest psr-rgb565-draw-blt: SUCCESS (7.080s)
[316.347849] [088/131] (708s left) gem_readwrite (write-bad-handle)
[316.405490] Subtest write-bad-handle: SKIP (0.000s)
[316.459787] [089/131] (708s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[316.525614] Starting subtest: disable-crc-after-crtc
[316.528274] Starting dynamic subtest: pipe-A-eDP-1
[318.192808] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.666s)
[318.203872] Starting dynamic subtest: pipe-B-eDP-1
[320.462588] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.270s)
[320.472412] Starting dynamic subtest: pipe-C-eDP-1
[322.727630] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.262s)
[322.737624] Starting dynamic subtest: pipe-D-eDP-1
[324.992266] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.263s)
[324.994646] Subtest disable-crc-after-crtc: SUCCESS (8.468s)
[325.823734] [090/131] (698s left) kms_cdclk (plane-scaling)
[325.897144] Starting subtest: plane-scaling
[325.899341] Starting dynamic subtest: pipe-A-eDP-1
[326.183323] Dynamic subtest pipe-A-eDP-1: SKIP (0.284s)
[326.194356] Starting dynamic subtest: pipe-B-eDP-1
[326.198839] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[326.208956] Starting dynamic subtest: pipe-C-eDP-1
[326.213640] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[326.223382] Starting dynamic subtest: pipe-D-eDP-1
[326.227756] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[326.232106] Subtest plane-scaling: SKIP (0.292s)
[327.053207] [091/131] (697s left) kms_plane_multiple (2x-tiling-x)
[327.121848] Starting subtest: 2x-tiling-x
[327.126503] Subtest 2x-tiling-x: SKIP (0.000s)
[327.210312] [092/131] (697s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[327.291215] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[327.295450] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[327.387486] [093/131] (697s left) kms_psr (psr-cursor-mmap-cpu)
[327.470540] Starting subtest: psr-cursor-mmap-cpu
[327.473223] Starting dynamic subtest: eDP-1
[329.160157] Dynamic subtest eDP-1: SUCCESS (1.690s)
[329.162459] Subtest psr-cursor-mmap-cpu: SUCCESS (1.691s)
[330.024322] [094/131] (694s left) gem_mmap_offset (partial-mmap)
[330.072237] Starting subtest: partial-mmap
[330.074816] Starting dynamic subtest: smem0
[330.076976] Dynamic subtest smem0: SUCCESS (0.003s)
[330.079022] Subtest partial-mmap: SUCCESS (0.004s)
[330.192350] [095/131] (694s left) i915_hangman (engine-error-state-capture)
[330.259490] Starting subtest: engine-error-state-capture
[330.261863] Starting dynamic subtest: rcs0
[333.944800] Dynamic subtest rcs0: SUCCESS (3.687s)
[333.958596] Starting dynamic subtest: bcs0
[339.959220] Dynamic subtest bcs0: SUCCESS (6.013s)
[339.973518] Starting dynamic subtest: vcs0
[345.912726] Dynamic subtest vcs0: SUCCESS (5.953s)
[345.927921] Starting dynamic subtest: vcs1
[351.927501] Dynamic subtest vcs1: SUCCESS (6.014s)
[351.941123] Starting dynamic subtest: vecs0
[356.919379] Dynamic subtest vecs0: SUCCESS (4.991s)
[356.932826] Starting dynamic subtest: ccs0
[362.935452] Dynamic subtest ccs0: SUCCESS (6.016s)
[362.938261] Subtest engine-error-state-capture: SUCCESS (32.688s)
[363.074747] [096/131] (661s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[363.158059] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[363.162304] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[363.230311] [097/131] (661s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[363.310129] Starting subtest: x-tiled-32bpp-rotate-180
[364.620736] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.311s)
[364.754999] [098/131] (660s left) kms_cursor_crc (cursor-offscreen-64x64)
[364.909883] Starting subtest: cursor-offscreen-64x64
[364.915817] Starting dynamic subtest: pipe-A-eDP-1
[366.836070] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.920s)
[366.863755] Starting dynamic subtest: pipe-D-eDP-1
[369.392304] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[369.394301] Subtest cursor-offscreen-64x64: SUCCESS (4.482s)
[370.259311] [099/131] (654s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[370.348888] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[370.375323] Starting dynamic subtest: pipe-A-plane-0
[370.664348] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[370.676266] Starting dynamic subtest: pipe-A-plane-3
[370.885996] Dynamic subtest pipe-A-plane-3: SUCCESS (0.221s)
[370.897138] Starting dynamic subtest: pipe-A-plane-5
[370.901632] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[371.959615] Starting dynamic subtest: pipe-B-plane-0
[372.261948] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[372.272437] Starting dynamic subtest: pipe-B-plane-3
[372.495137] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[372.506277] Starting dynamic subtest: pipe-B-plane-5
[372.510926] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[372.812158] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.464s)
[373.634796] [100/131] (651s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[373.713697] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[373.718367] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[373.826727] [101/131] (651s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[373.899401] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[373.908892] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.008s)
[373.984291] [102/131] (651s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[374.064515] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[374.068645] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[374.157875] [103/131] (650s left) gem_render_copy_redux (flink)
[374.213664] Starting subtest: flink
[374.943106] Subtest flink: SUCCESS (0.730s)
[375.031955] [104/131] (650s left) gem_ctx_create (basic)
[375.090085] Starting subtest: basic
[375.091960] Subtest basic: SUCCESS (0.000s)
[375.273094] [105/131] (649s left) i915_pm_rpm (gem-idle)
[377.180701] Starting subtest: gem-idle
[383.376601] Subtest gem-idle: SUCCESS (6.192s)
[383.689504] [106/131] (641s left) gem_ctx_isolation (dirty-create)
[384.960633] Starting subtest: dirty-create
[384.962947] Starting dynamic subtest: rcs0
[385.144775] Dynamic subtest rcs0: SUCCESS (0.184s)
[385.155958] Starting dynamic subtest: bcs0
[385.339937] Dynamic subtest bcs0: SUCCESS (0.194s)
[385.351045] Starting dynamic subtest: vcs0
[385.553991] Dynamic subtest vcs0: SUCCESS (0.213s)
[385.564076] Starting dynamic subtest: vcs1
[387.109853] Dynamic subtest vcs1: SUCCESS (1.554s)
[387.121770] Starting dynamic subtest: vecs0
[389.150243] Dynamic subtest vecs0: SUCCESS (2.038s)
[389.162582] Starting dynamic subtest: ccs0
[391.282600] Dynamic subtest ccs0: SUCCESS (2.131s)
[391.284886] Subtest dirty-create: SUCCESS (6.320s)
[391.511391] [107/131] (633s left) gem_exec_schedule (independent)
[391.582862] Starting subtest: independent
[391.585363] Starting dynamic subtest: rcs0
[392.985387] Dynamic subtest rcs0: SUCCESS (1.409s)
[392.998814] Starting dynamic subtest: vcs0
[394.979744] Dynamic subtest vcs0: SUCCESS (1.990s)
[394.992885] Starting dynamic subtest: vcs1
[396.965482] Dynamic subtest vcs1: SUCCESS (1.983s)
[396.979231] Starting dynamic subtest: vecs0
[398.948513] Dynamic subtest vecs0: SUCCESS (1.980s)
[398.961626] Starting dynamic subtest: ccs0
[400.985393] Dynamic subtest ccs0: SUCCESS (2.034s)
[400.987994] Subtest independent: SUCCESS (9.408s)
[401.286374] [108/131] (624s left) kms_lease (lease-invalid-plane)
[401.361562] Starting subtest: lease-invalid-plane
[401.363961] Starting dynamic subtest: pipe-A-eDP-1
[401.366202] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[401.381060] Starting dynamic subtest: pipe-B-eDP-1
[401.383281] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[401.395867] Starting dynamic subtest: pipe-C-eDP-1
[401.397768] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[401.407230] Starting dynamic subtest: pipe-D-eDP-1
[401.409100] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[401.410948] Subtest lease-invalid-plane: SUCCESS (0.004s)
[401.450410] [109/131] (623s left) core_setmaster (master-drop-set-user)
[401.535966] Starting subtest: master-drop-set-user
[401.547558] Subtest master-drop-set-user: SUCCESS (0.015s)
[401.586733] [110/131] (623s left) kms_tv_load_detect (load-detect)
[401.645307] Subtest load-detect: SKIP (0.000s)
[401.712926] [111/131] (623s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[401.774894] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[401.857575] [112/131] (623s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[401.938601] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[409.025978] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.087s)
[409.149779] [113/131] (616s left) drm_read (fault-buffer)
[409.285523] Starting subtest: fault-buffer
[409.287890] Subtest fault-buffer: SUCCESS (0.000s)
[409.409848] [114/131] (616s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[409.467374] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[409.573767] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[409.652035] [115/131] (615s left) syncobj_timeline (wait-any-snapshot)
[409.707139] Starting subtest: wait-any-snapshot
[409.785938] Subtest wait-any-snapshot: SUCCESS (0.081s)
[409.864189] [116/131] (615s left) kms_color (ctm-red-to-blue)
[409.932717] Starting subtest: ctm-red-to-blue
[409.934955] Starting dynamic subtest: pipe-A-eDP-1
[410.630104] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s)
[410.640321] Starting dynamic subtest: pipe-B-eDP-1
[412.037595] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s)
[412.048864] Starting dynamic subtest: pipe-C-eDP-1
[413.403824] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[413.414476] Starting dynamic subtest: pipe-D-eDP-1
[414.728755] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[414.731055] Subtest ctm-red-to-blue: SUCCESS (4.795s)
[415.539268] [117/131] (610s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[415.620671] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[415.624964] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[415.741414] [118/131] (609s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[415.822783] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[415.825146] Starting dynamic subtest: pipe-A-eDP-1
[415.884516] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[415.895066] Starting dynamic subtest: pipe-B-eDP-1
[415.950698] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[415.961892] Starting dynamic subtest: pipe-C-eDP-1
[416.017132] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[416.028038] Starting dynamic subtest: pipe-D-eDP-1
[416.085726] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[416.090285] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[418.087160] [119/131] (607s left) kms_pm_rpm (pm-caching)
[420.192128] Starting subtest: pm-caching
[420.197082] Subtest pm-caching: SKIP (0.000s)
[420.575276] [120/131] (605s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[420.665399] Starting subtest: y-tiled-8bpp-rotate-0
[420.670002] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[420.787238] [121/131] (605s left) gem_exec_reloc (basic-write-gtt)
[420.840604] Subtest basic-write-gtt: SKIP (0.000s)
[420.933164] [122/131] (604s left) gem_exec_schedule (smoketest-all)
[421.009528] Starting subtest: smoketest-all
[453.386695] Subtest smoketest-all: SUCCESS (32.337s)
[455.030305] [123/131] (570s left) gem_mmap_gtt (big-copy)
[455.089202] Subtest big-copy: SKIP (0.000s)
[455.146338] [124/131] (570s left) gem_render_copy (linear-to-vebox-y-tiled)
[455.201400] Starting subtest: linear-to-vebox-y-tiled
[455.206403] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[455.389749] [125/131] (570s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[455.754306] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[456.570314] [126/131] (569s left) dumb_buffer (map-uaf)
[456.621458] Starting subtest: map-uaf
[456.623810] Subtest map-uaf: SUCCESS (0.005s)
[456.713458] [127/131] (569s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[456.797807] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[463.640592] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.847s)
[463.764226] [128/131] (562s left) kms_vrr (seamless-rr-switch-vrr)
[463.846160] Starting subtest: seamless-rr-switch-vrr
[463.851623] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[463.931102] [129/131] (562s left) gem_shrink (reclaim)
[463.983929] Starting subtest: reclaim
[466.429473] Subtest reclaim: SUCCESS (2.445s)
[466.585144] [130/131] (559s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[466.669771] Starting subtest: fbc-psr-sprite-mmap-cpu
[466.672130] Starting dynamic subtest: eDP-1
[466.676546] Dynamic subtest eDP-1: SKIP (0.000s)
[466.680966] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[466.760014] [131/131] (559s left) kms_flip (flip-vs-absolute-wf_vblank)
[466.841631] Starting subtest: flip-vs-absolute-wf_vblank
[466.844031] Starting dynamic subtest: A-eDP1
[475.774217] Dynamic subtest A-eDP1: SUCCESS (8.937s)
[475.785980] Starting dynamic subtest: B-eDP1
[484.700992] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[484.712490] Starting dynamic subtest: C-eDP1
[493.656944] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[493.669172] Starting dynamic subtest: D-eDP1
[502.595206] Dynamic subtest D-eDP1: SUCCESS (8.937s)
[502.597611] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.722s)
[503.767150] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: core_debugfs
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_partial_pwrite_pread
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_reg_read
results: parsing output: 21/ for test: gem_wait
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: kms_dp_link_training
results: parsing output: 29/ for test: i915_drm_fdinfo
results: parsing output: 30/ for test: kms_plane_scaling
results: parsing output: 31/ for test: gem_exec_nop
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_caching
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: gem_ctx_exec
results: parsing output: 41/ for test: api_intel_allocator
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_ctx_param
results: parsing output: 45/ for test: gem_tiled_swapping
results: parsing output: 46/ for test: kms_atomic
results: parsing output: 47/ for test: kms_hdr
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: kms_content_protection
results: parsing output: 53/ for test: gem_softpin
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: gem_ppgtt
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: prime_busy
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: gen9_exec_parse
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: gem_exec_whisper
results: parsing output: 67/ for test: kms_pm_dc
results: parsing output: 68/ for test: gem_exec_flush
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: i915_suspend
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: kms_setmode
results: parsing output: 73/ for test: sw_sync
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: gem_exec_basic
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_lmem_swapping
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_selftest
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_readwrite
results: parsing output: 88/ for test: kms_pipe_crc_basic
results: parsing output: 89/ for test: kms_cdclk
results: parsing output: 90/ for test: kms_plane_multiple
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: gem_mmap_offset
results: parsing output: 94/ for test: i915_hangman
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_render_copy_redux
results: parsing output: 103/ for test: gem_ctx_create
results: parsing output: 104/ for test: i915_pm_rpm
results: parsing output: 105/ for test: gem_ctx_isolation
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: kms_lease
results: parsing output: 108/ for test: core_setmaster
results: parsing output: 109/ for test: kms_tv_load_detect
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: drm_read
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_color
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: kms_chamelium_edid
results: parsing output: 125/ for test: dumb_buffer
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_vrr
results: parsing output: 128/ for test: gem_shrink
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_flip
Done.