[56.883311] Initializing watchdogs
[56.883383]   /dev/watchdog0
[56.898526] [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]
[56.903684] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.906087] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.909557] [001/155] (960s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[57.139671] Starting subtest: cursor-rapid-movement-64x21
[57.194944] Subtest cursor-rapid-movement-64x21: SKIP (0.049s)
[57.439254] [002/155] (960s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[57.552273] Starting subtest: psr-rgb101010-draw-render
[65.013875] Subtest psr-rgb101010-draw-render: SUCCESS (7.439s)
[65.149119] [003/155] (952s left) gem_pxp (create-protected-buffer)
[65.274717] Starting subtest: create-protected-buffer
[65.277088] Subtest create-protected-buffer: SUCCESS (0.000s)
[65.389217] [004/155] (952s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[65.448629] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[65.550535] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[65.640872] [005/155] (951s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[65.746809] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[65.751364] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[65.847814] [006/155] (951s left) kms_psr (psr2-dpms)
[65.944398] Starting subtest: psr2-dpms
[65.946762] Starting dynamic subtest: eDP-1
[68.935681] Dynamic subtest eDP-1: SUCCESS (2.986s)
[68.938117] Subtest psr2-dpms: SUCCESS (2.986s)
[69.804193] [007/155] (947s left) drm_mm (drm_mm)
[69.838238] Starting subtest: drm_mm
[69.851895] Starting dynamic subtest: drm_test_mm_init
[69.944741] Dynamic subtest drm_test_mm_init: SUCCESS (0.095s)
[69.954205] Starting dynamic subtest: drm_test_mm_debug
[70.033524] Dynamic subtest drm_test_mm_debug: SUCCESS (0.089s)
[70.041591] Starting dynamic subtest: drm_test_mm_align32
[70.120480] Dynamic subtest drm_test_mm_align32: SUCCESS (0.086s)
[70.130061] Starting dynamic subtest: drm_test_mm_align64
[70.219326] Dynamic subtest drm_test_mm_align64: SUCCESS (0.099s)
[70.228675] Starting dynamic subtest: drm_test_mm_lowest
[70.309617] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.089s)
[70.319129] Starting dynamic subtest: drm_test_mm_highest
[70.399496] Dynamic subtest drm_test_mm_highest: SUCCESS (0.090s)
[70.401774] Subtest drm_mm: SUCCESS (0.561s)
[70.562363] [008/155] (947s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[70.669669] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[77.549432] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.882s)
[77.689447] [009/155] (940s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[77.776294] Starting subtest: fbc-psr2-sprite-mmap-gtt
[77.778285] Starting dynamic subtest: eDP-1
[77.782501] Dynamic subtest eDP-1: SKIP (0.000s)
[77.786731] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[77.854551] [010/155] (939s left) kms_flip (flip-vs-absolute-wf_vblank)
[77.947769] Starting subtest: flip-vs-absolute-wf_vblank
[77.950497] Starting dynamic subtest: A-eDP1
[86.893055] Dynamic subtest A-eDP1: SUCCESS (8.943s)
[86.902918] Starting dynamic subtest: B-eDP1
[95.826163] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[95.836075] Starting dynamic subtest: C-eDP1
[104.740704] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[104.749640] Starting dynamic subtest: D-eDP1
[113.682038] Dynamic subtest D-eDP1: SUCCESS (8.939s)
[113.686507] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.736s)
[114.906222] [011/155] (902s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen)
[115.016541] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen
[115.020600] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[115.106990] [012/155] (902s left) gem_gtt_cpu_tlb
[115.216359] [013/155] (902s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[115.312096] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[115.316410] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[115.426056] [014/155] (902s left) perf_pmu (busy-accuracy-2)
[115.472072] Starting subtest: busy-accuracy-2
[115.474319] Starting dynamic subtest: rcs0
[118.519230] Dynamic subtest rcs0: SUCCESS (3.044s)
[118.531258] Starting dynamic subtest: bcs0
[121.584953] Dynamic subtest bcs0: SUCCESS (3.065s)
[121.596089] Starting dynamic subtest: vcs0
[124.630837] Dynamic subtest vcs0: SUCCESS (3.044s)
[124.642067] Starting dynamic subtest: vcs1
[127.673860] Dynamic subtest vcs1: SUCCESS (3.043s)
[127.682898] Starting dynamic subtest: vecs0
[130.717934] Dynamic subtest vecs0: SUCCESS (3.043s)
[130.726530] Starting dynamic subtest: ccs0
[133.772626] Dynamic subtest ccs0: SUCCESS (3.053s)
[133.775606] Subtest busy-accuracy-2: SUCCESS (18.299s)
[133.891202] [015/155] (884s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render)
[133.996536] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render
[134.000877] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[134.089394] [016/155] (883s left) syncobj_wait (wait-any-interrupted)
[134.156648] Starting subtest: wait-any-interrupted
[134.264574] Subtest wait-any-interrupted: SUCCESS (0.105s)
[134.350737] [017/155] (883s left) kms_properties (get_properties-sanity-non-atomic)
[134.439316] Starting subtest: get_properties-sanity-non-atomic
[134.441726] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[134.513322] [018/155] (883s left) kms_async_flips (test-time-stamp-atomic)
[134.606764] Starting subtest: test-time-stamp-atomic
[134.983217] Starting dynamic subtest: pipe-A-eDP-1
[135.821939] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.837s)
[136.210623] Starting dynamic subtest: pipe-B-eDP-1
[137.046563] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.840s)
[137.418135] Starting dynamic subtest: pipe-C-eDP-1
[138.190612] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.779s)
[138.556931] Starting dynamic subtest: pipe-D-eDP-1
[139.325999] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s)
[139.328433] Subtest test-time-stamp-atomic: SUCCESS (4.718s)
[140.489679] [019/155] (877s left) gem_spin_batch (legacy-resubmit)
[140.560323] Starting subtest: legacy-resubmit
[140.562670] Starting dynamic subtest: default
[140.565065] Dynamic subtest default: SUCCESS (0.007s)
[140.574658] Starting dynamic subtest: render
[140.576481] Dynamic subtest render: SUCCESS (0.001s)
[140.585344] Starting dynamic subtest: bsd
[140.587172] Dynamic subtest bsd: SUCCESS (0.002s)
[140.595331] Starting dynamic subtest: bsd1
[140.597235] Dynamic subtest bsd1: SUCCESS (0.003s)
[140.605282] Starting dynamic subtest: bsd2
[140.607128] Dynamic subtest bsd2: SUCCESS (0.001s)
[140.615382] Starting dynamic subtest: blt
[140.617296] Dynamic subtest blt: SUCCESS (0.003s)
[140.625303] Starting dynamic subtest: vebox
[140.627187] Dynamic subtest vebox: SUCCESS (0.004s)
[140.629073] Subtest legacy-resubmit: SUCCESS (0.025s)
[140.820558] [020/155] (877s left) perf_pmu (interrupts)
[140.866566] Starting subtest: interrupts
[141.945267] Subtest interrupts: SUCCESS (1.078s)
[142.049419] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true
[142.052867] [021/155] (876s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[142.154148] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[142.158484] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[142.263896] [022/155] (875s left) kms_chamelium_audio (dp-audio)
[142.645958] Subtest dp-audio: SKIP (0.000s)
[143.504529] [023/155] (874s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[143.592836] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[143.619455] Starting dynamic subtest: pipe-A-plane-0
[144.008080] Dynamic subtest pipe-A-plane-0: SUCCESS (0.389s)
[144.017988] Starting dynamic subtest: pipe-A-plane-3
[144.352803] Dynamic subtest pipe-A-plane-3: SUCCESS (0.344s)
[145.509920] Starting dynamic subtest: pipe-B-plane-0
[145.911892] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[145.921480] Starting dynamic subtest: pipe-B-plane-3
[146.234335] Dynamic subtest pipe-B-plane-3: SUCCESS (0.322s)
[146.555110] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (2.963s)
[147.394685] [024/155] (870s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[147.483893] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[147.488324] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[147.558294] [025/155] (870s left) kms_lease (multimaster-lease)
[147.652292] Starting subtest: multimaster-lease
[147.654562] Subtest multimaster-lease: SUCCESS (0.003s)
[147.766113] [026/155] (870s left) gem_exec_schedule (u-semaphore-noskip)
[147.831588] Starting subtest: u-semaphore-noskip
[148.236091] Subtest u-semaphore-noskip: SUCCESS (0.408s)
[148.564851] [027/155] (869s left) kms_debugfs (display-off-read-all)
[148.657681] Starting subtest: display-off-read-all
[148.945261] Subtest display-off-read-all: SUCCESS (0.288s)
[149.824152] [028/155] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[149.934352] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[149.938457] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[150.034192] [029/155] (868s left) gem_exec_reloc (basic-wc-noreloc)
[150.092465] Subtest basic-wc-noreloc: SKIP (0.000s)
[150.177595] [030/155] (868s left) gem_ctx_persistence (legacy-engines-mixed)
[150.241705] Starting subtest: legacy-engines-mixed
[150.244166] Starting dynamic subtest: render
[150.314664] Dynamic subtest render: SUCCESS (0.072s)
[150.325840] Starting dynamic subtest: bsd1
[150.369942] Dynamic subtest bsd1: SUCCESS (0.054s)
[150.381612] Starting dynamic subtest: bsd2
[150.431897] Dynamic subtest bsd2: SUCCESS (0.059s)
[150.442677] Starting dynamic subtest: blt
[150.488606] Dynamic subtest blt: SUCCESS (0.055s)
[150.498467] Starting dynamic subtest: vebox
[150.541243] Dynamic subtest vebox: SUCCESS (0.051s)
[150.543314] Subtest legacy-engines-mixed: SUCCESS (0.301s)
[150.629863] [031/155] (868s left) kms_vblank (ts-continuation-suspend)
[150.718943] Starting subtest: ts-continuation-suspend
[150.720592] Starting dynamic subtest: pipe-A-eDP-1
[167.322612] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.465s)
[167.337283] Starting dynamic subtest: pipe-D-eDP-1
[184.319333] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.193s)
[184.321726] Subtest ts-continuation-suspend: SUCCESS (4.661s)
[185.150012] [032/155] (833s left) i915_pciid
[185.303553] [033/155] (833s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[185.408875] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[189.723023] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.285s)
[190.924807] [034/155] (827s left) kms_chamelium_frames (hdmi-crc-fast)
[191.317101] Subtest hdmi-crc-fast: SKIP (0.000s)
[192.139888] [035/155] (826s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[192.238845] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[192.242770] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[192.329676] [036/155] (826s left) gem_linear_blits (normal)
[192.675365] Starting subtest: normal
[196.391114] Subtest normal: SUCCESS (3.700s)
[196.509699] [037/155] (822s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt)
[196.668312] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt
[196.672747] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[196.776771] [038/155] (822s left) kms_cursor_crc (cursor-offscreen-64x64)
[196.955310] Starting subtest: cursor-offscreen-64x64
[196.961066] Starting dynamic subtest: pipe-A-eDP-1
[198.936967] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.971s)
[198.969341] Starting dynamic subtest: pipe-D-eDP-1
[201.603303] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.639s)
[201.605636] Subtest cursor-offscreen-64x64: SUCCESS (4.637s)
[202.449742] [039/155] (816s left) kms_invalid_mode (zero-clock)
[202.556500] Starting subtest: zero-clock
[202.558826] Starting dynamic subtest: pipe-A-eDP-1
[202.843479] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[202.854647] Starting dynamic subtest: pipe-B-eDP-1
[202.856543] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[202.866657] Starting dynamic subtest: pipe-C-eDP-1
[202.869135] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[202.879198] Starting dynamic subtest: pipe-D-eDP-1
[202.881434] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[202.883661] Subtest zero-clock: SUCCESS (0.294s)
[203.685397] [040/155] (815s left) gem_vm_create (invalid-destroy)
[203.742625] Starting subtest: invalid-destroy
[203.744981] Subtest invalid-destroy: SUCCESS (0.002s)
[203.869055] [041/155] (815s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[203.969420] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[212.890662] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.918s)
[213.004702] [042/155] (806s left) gem_exec_schedule (fifo)
[213.080937] Starting subtest: fifo
[213.083270] Starting dynamic subtest: rcs0
[213.176035] Dynamic subtest rcs0: SUCCESS (0.101s)
[213.187255] Starting dynamic subtest: vcs0
[213.269978] Dynamic subtest vcs0: SUCCESS (0.093s)
[213.284104] Starting dynamic subtest: vcs1
[213.347382] Dynamic subtest vcs1: SUCCESS (0.076s)
[213.367536] Starting dynamic subtest: vecs0
[213.423560] Dynamic subtest vecs0: SUCCESS (0.076s)
[213.436542] Starting dynamic subtest: ccs0
[213.501070] Dynamic subtest ccs0: SUCCESS (0.075s)
[213.503641] Subtest fifo: SUCCESS (0.426s)
[215.303255] [043/155] (803s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[215.404344] Starting subtest: pr-overlay-plane-move-continuous-sf
[215.408680] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[215.471884] [044/155] (803s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[215.565750] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[215.570059] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[215.667249] [045/155] (803s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite)
[215.774152] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite
[215.778330] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[215.890584] [046/155] (803s left) gem_ccs (ctrl-surf-copy-new-ctx)
[215.947947] Starting subtest: ctrl-surf-copy-new-ctx
[215.952084] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[216.054255] [047/155] (803s left) perf (polling)
[216.207154] Starting subtest: polling
[216.209322] Starting dynamic subtest: 0-rcs0
[226.221285] Dynamic subtest 0-rcs0: SUCCESS (10.018s)
[226.233225] Starting dynamic subtest: 1-vcs1
[236.242093] Dynamic subtest 1-vcs1: SUCCESS (10.020s)
[236.244896] Subtest polling: SUCCESS (20.040s)
[236.296685] [048/155] (783s left) syncobj_timeline (invalid-query-illegal-handle)
[236.356209] Starting subtest: invalid-query-illegal-handle
[236.358550] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[236.474955] [049/155] (782s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[236.586764] Starting subtest: read-crc-frame-sequence
[236.589090] Starting dynamic subtest: pipe-A-eDP-1
[237.302063] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[237.315391] Starting dynamic subtest: pipe-B-eDP-1
[238.736628] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.432s)
[238.750135] Starting dynamic subtest: pipe-C-eDP-1
[240.044411] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.306s)
[240.056413] Starting dynamic subtest: pipe-D-eDP-1
[241.372595] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[241.374933] Subtest read-crc-frame-sequence: SUCCESS (4.787s)
[242.195995] [050/155] (777s left) kms_color (ctm-blue-to-red)
[242.290540] Starting subtest: ctm-blue-to-red
[242.292480] Starting dynamic subtest: pipe-A-eDP-1
[243.001189] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[243.012342] Starting dynamic subtest: pipe-B-eDP-1
[244.415914] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.411s)
[244.427124] Starting dynamic subtest: pipe-C-eDP-1
[245.792593] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[245.805895] Starting dynamic subtest: pipe-D-eDP-1
[247.117435] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[247.119850] Subtest ctm-blue-to-red: SUCCESS (4.828s)
[247.937044] [051/155] (771s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[248.027661] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[248.029960] Starting dynamic subtest: pipe-A-eDP-1
[248.055316] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[248.068006] Starting dynamic subtest: pipe-B-eDP-1
[248.092178] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[248.102831] Starting dynamic subtest: pipe-C-eDP-1
[248.126860] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[248.137024] Starting dynamic subtest: pipe-D-eDP-1
[248.161169] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[248.165275] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[250.287097] [052/155] (769s left) kms_content_protection (dp-mst-lic-type-1)
[250.421988] Starting subtest: dp-mst-lic-type-1
[250.426640] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[250.568588] [053/155] (769s left) gem_mmap_wc (copy)
[250.626501] Subtest copy: SKIP (0.000s)
[250.697673] [054/155] (768s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-onoff)
[250.793870] Starting subtest: fbchdr-2p-primscrn-spr-indfb-onoff
[250.797751] Subtest fbchdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[250.898918] [055/155] (768s left) gem_create (create-ext-cpu-access-sanity-check)
[251.067043] Starting subtest: create-ext-cpu-access-sanity-check
[251.071532] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[251.136988] [056/155] (768s left) kms_cursor_crc (cursor-sliding-512x170)
[251.417312] Starting subtest: cursor-sliding-512x170
[251.421850] Subtest cursor-sliding-512x170: SKIP (0.001s)
[251.546224] [057/155] (768s left) syncobj_timeline (wait-all-snapshot)
[251.598247] Starting subtest: wait-all-snapshot
[251.680400] Subtest wait-all-snapshot: SUCCESS (0.082s)
[251.758200] [058/155] (768s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-blt)
[251.860353] Starting subtest: fbchdr-rgb565-draw-blt
[251.864622] Subtest fbchdr-rgb565-draw-blt: SKIP (0.000s)
[251.965684] [059/155] (767s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[252.070717] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[252.074678] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[252.161179] [060/155] (767s left) gem_sync (basic-store-each)
[252.227506] Starting subtest: basic-store-each
[254.570290] Subtest basic-store-each: SUCCESS (2.350s)
[254.769759] [061/155] (765s left) gem_unref_active_buffers
[254.988454] [062/155] (764s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[255.098610] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[256.111334] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.012s)
[256.236807] [063/155] (763s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[256.332321] Starting subtest: y-tiled-64bpp-rotate-90
[256.336709] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[256.422520] [064/155] (763s left) kms_rotation_crc (primary-rotation-270)
[256.514751] Starting subtest: primary-rotation-270
[256.518234] Subtest primary-rotation-270: SKIP (0.001s)
[256.589462] [065/155] (763s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt)
[256.689339] Starting subtest: psrhdr-farfromfence-mmap-gtt
[256.692709] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[256.809880] [066/155] (763s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[256.893924] Starting subtest: multiplane-rotation-cropping-bottom
[274.380333] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.482s)
[274.530073] [067/155] (745s left) kms_flip (2x-nonexisting-fb)
[274.631613] Starting subtest: 2x-nonexisting-fb
[274.641098] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[274.737972] [068/155] (745s left) kms_psr (fbc-psr-dpms)
[274.822951] Starting subtest: fbc-psr-dpms
[274.824839] Starting dynamic subtest: eDP-1
[274.828371] Dynamic subtest eDP-1: SKIP (0.000s)
[274.831817] Subtest fbc-psr-dpms: SKIP (0.001s)
[274.899671] [069/155] (745s left) api_intel_bb (object-noreloc-keep-cache-simple)
[274.955440] Starting subtest: object-noreloc-keep-cache-simple
[274.958289] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[275.076003] [070/155] (745s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu)
[275.173764] Starting subtest: hdr-rgb565-draw-mmap-cpu
[275.177087] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[275.268989] [071/155] (745s left) kms_plane_scaling (invalid-parameters)
[275.354155] Starting subtest: invalid-parameters
[275.356122] Starting dynamic subtest: less-than-1-height-src
[275.367156] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[275.377505] Starting dynamic subtest: less-than-1-width-src
[275.382003] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[275.383660] Subtest invalid-parameters: SUCCESS (0.028s)
[275.494195] [072/155] (744s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[275.585641] Starting subtest: fbcpsr-suspend
[315.721150] Subtest fbcpsr-suspend: SUCCESS (10.113s)
[315.862533] [073/155] (704s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[315.927216] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[316.033387] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[316.112990] [074/155] (704s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[316.219207] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc
[316.223534] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[316.315196] [075/155] (704s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[316.402437] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[316.520499] [076/155] (704s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt)
[316.625303] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt
[316.629600] Subtest hdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[316.731695] [077/155] (703s left) gem_exec_fence (invalid-timeline-fence-array)
[317.320174] Starting subtest: invalid-timeline-fence-array
[317.322601] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[318.304478] [078/155] (702s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[318.416772] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[318.421200] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[318.506564] [079/155] (702s left) gem_request_retire (retire-vma-not-inactive)
[318.565545] Starting subtest: retire-vma-not-inactive
[318.626501] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[318.764295] [080/155] (701s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[318.860868] Starting subtest: fbc-pr-cursor-mmap-gtt
[318.865374] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[318.947695] [081/155] (701s left) gem_ctx_isolation (preservation)
[319.004637] Starting subtest: preservation
[319.007044] Starting dynamic subtest: rcs0
[319.148785] Dynamic subtest rcs0: SUCCESS (0.142s)
[319.163368] Starting dynamic subtest: bcs0
[319.311714] Dynamic subtest bcs0: SUCCESS (0.161s)
[319.324403] Starting dynamic subtest: vcs0
[319.477159] Dynamic subtest vcs0: SUCCESS (0.163s)
[319.487893] Starting dynamic subtest: vcs1
[321.271767] Dynamic subtest vcs1: SUCCESS (1.784s)
[321.282721] Starting dynamic subtest: vecs0
[323.328688] Dynamic subtest vecs0: SUCCESS (2.048s)
[323.340643] Starting dynamic subtest: ccs0
[325.336432] Dynamic subtest ccs0: SUCCESS (2.000s)
[325.338730] Subtest preservation: SUCCESS (6.304s)
[325.560501] [082/155] (695s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt)
[325.674837] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt
[325.678996] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[325.774548] [083/155] (695s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[325.860985] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[325.862963] Starting dynamic subtest: pipe-A-eDP-1
[326.783592] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.915s)
[326.794400] Starting dynamic subtest: pipe-B-eDP-1
[328.431165] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.639s)
[328.442704] Starting dynamic subtest: pipe-C-eDP-1
[329.941373] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.508s)
[329.953357] Starting dynamic subtest: pipe-D-eDP-1
[331.533723] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.588s)
[331.535603] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.655s)
[332.734312] [084/155] (688s left) gen9_exec_parse (bb-secure)
[332.796582] Subtest bb-secure: SKIP (0.000s)
[332.877162] [085/155] (688s left) gem_lmem_swapping (basic)
[332.921689] Subtest basic: SKIP (0.000s)
[332.964372] [086/155] (688s left) kms_force_connector_basic (prune-stale-modes)
[333.054191] Starting subtest: prune-stale-modes
[333.501765] Subtest prune-stale-modes: SUCCESS (0.450s)
[333.653834] [087/155] (687s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[333.748328] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[337.407191] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.659s)
[338.571155] [088/155] (682s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[338.659944] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[338.663891] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[338.733213] [089/155] (682s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[338.825234] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[338.827511] Starting dynamic subtest: pipe-A-eDP-1
[338.847812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[338.859079] Starting dynamic subtest: pipe-B-eDP-1
[338.877370] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[338.887782] Starting dynamic subtest: pipe-C-eDP-1
[338.906468] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[338.916591] Starting dynamic subtest: pipe-D-eDP-1
[338.935266] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[338.937098] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[341.070930] [090/155] (680s left) kms_dsc (dsc-with-output-formats-with-bpc)
[341.158965] Starting subtest: dsc-with-output-formats-with-bpc
[341.214413] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[341.258622] [091/155] (679s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[341.363112] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[342.408974] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.045s)
[342.523722] [092/155] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[342.626866] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[342.630605] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[342.731251] [093/155] (678s left) i915_pm_rpm (debugfs-forcewake-user)
[344.357645] Starting subtest: debugfs-forcewake-user
[355.775253] Subtest debugfs-forcewake-user: SUCCESS (11.420s)
[356.193377] [094/155] (665s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[356.290593] Starting subtest: yf-tiled-8bpp-rotate-90
[356.295094] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[356.385711] [095/155] (665s left) sriov_basic (enable-vfs-autoprobe-off)
[356.444189] Starting subtest: enable-vfs-autoprobe-off
[356.446728] Starting dynamic subtest: numvfs-1
[356.528444] Dynamic subtest numvfs-1: FAIL (0.029s)
[356.541846] Starting dynamic subtest: numvfs-2
[356.615397] Dynamic subtest numvfs-2: FAIL (0.004s)
[356.627172] Starting dynamic subtest: numvfs-3
[356.700371] Dynamic subtest numvfs-3: FAIL (0.004s)
[356.712601] Starting dynamic subtest: numvfs-4
[356.786394] Dynamic subtest numvfs-4: FAIL (0.004s)
[356.798778] Starting dynamic subtest: numvfs-5
[356.873615] Dynamic subtest numvfs-5: FAIL (0.004s)
[356.886434] Starting dynamic subtest: numvfs-6
[356.960878] Dynamic subtest numvfs-6: FAIL (0.004s)
[356.974296] Starting dynamic subtest: numvfs-7
[357.044503] Dynamic subtest numvfs-7: FAIL (0.004s)
[357.056579] Starting dynamic subtest: numvfs-random
[357.126412] Dynamic subtest numvfs-random: FAIL (0.004s)
[357.138175] Starting dynamic subtest: numvfs-all
[357.197574] Dynamic subtest numvfs-all: FAIL (0.529s)
[357.199488] Subtest enable-vfs-autoprobe-off: FAIL (0.593s)
[357.239333] [096/155] (664s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[357.346879] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[357.350408] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[357.452196] [097/155] (664s left) syncobj_wait (wait-for-submit-complex)
[357.504147] Starting subtest: wait-for-submit-complex
[357.564870] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[357.643053] [098/155] (663s left) gem_exec_reloc (basic-write-wc-noreloc)
[357.696897] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[357.772163] [099/155] (663s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[357.863562] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[357.867110] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[357.943269] [100/155] (663s left) gem_sync (basic-each)
[358.011475] Starting subtest: basic-each
[360.329333] Subtest basic-each: SUCCESS (2.326s)
[360.518812] [101/155] (661s left) syncobj_timeline (reset-multiple-signaled)
[360.563816] Starting subtest: reset-multiple-signaled
[360.565980] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[360.678833] [102/155] (661s left) gem_exec_reloc (basic-write-wc-active)
[360.735407] Subtest basic-write-wc-active: SKIP (0.000s)
[360.796254] [103/155] (660s left) kms_addfb_basic (addfb25-modifier-no-flag)
[360.892249] Starting subtest: addfb25-modifier-no-flag
[360.894567] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[360.994059] [104/155] (660s left) prime_mmap (test_correct_cpu_write)
[361.051870] Starting subtest: test_correct_cpu_write
[361.053855] Starting dynamic subtest: test_correct_cpu_write-smem
[361.055887] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[361.057907] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[361.148833] [105/155] (660s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render)
[361.247160] Starting subtest: fbcpsrhdr-rgb101010-draw-render
[361.250529] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s)
[361.377593] [106/155] (660s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-pgflip-blt)
[361.472739] Starting subtest: psrhdr-2p-primscrn-shrfb-pgflip-blt
[361.476253] Subtest psrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[361.563736] [107/155] (660s left) api_intel_allocator (standalone)
[361.622305] Starting subtest: standalone
[361.638014] Subtest standalone: SUCCESS (0.018s)
[361.749927] [108/155] (660s left) syncobj_basic (bad-handle-to-fd)
[361.805641] Starting subtest: bad-handle-to-fd
[361.807474] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[361.896028] [109/155] (660s left) syncobj_timeline (etime-single-wait-all-submitted)
[361.946966] Starting subtest: etime-single-wait-all-submitted
[362.048205] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s)
[362.141055] [110/155] (659s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-onoff)
[362.248628] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-onoff
[362.252080] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[362.346160] [111/155] (659s left) gen9_exec_parse (unaligned-jump)
[362.392887] Subtest unaligned-jump: SKIP (0.000s)
[362.458192] [112/155] (659s left) kms_flip (dpms-off-confusion-interruptible)
[362.551205] Starting subtest: dpms-off-confusion-interruptible
[362.553245] Starting dynamic subtest: A-eDP1
[371.237676] Dynamic subtest A-eDP1: SUCCESS (8.683s)
[371.252863] Starting dynamic subtest: B-eDP1
[379.939342] Dynamic subtest B-eDP1: SUCCESS (8.696s)
[379.951721] Starting dynamic subtest: C-eDP1
[388.626405] Dynamic subtest C-eDP1: SUCCESS (8.683s)
[388.637643] Starting dynamic subtest: D-eDP1
[397.326079] Dynamic subtest D-eDP1: SUCCESS (8.696s)
[397.331260] Subtest dpms-off-confusion-interruptible: SUCCESS (34.769s)
[398.562658] [113/155] (623s left) kms_plane_scaling (planes-upscale-factor-0-25)
[398.667968] Starting subtest: planes-upscale-factor-0-25
[398.670199] Starting dynamic subtest: pipe-A
[398.727971] Dynamic subtest pipe-A: SUCCESS (0.062s)
[398.739647] Starting dynamic subtest: pipe-B
[399.858775] Dynamic subtest pipe-B: SUCCESS (1.130s)
[399.870339] Starting dynamic subtest: pipe-C
[401.045780] Dynamic subtest pipe-C: SUCCESS (1.185s)
[401.057958] Starting dynamic subtest: pipe-D
[402.132466] Dynamic subtest pipe-D: SUCCESS (1.086s)
[402.134753] Subtest planes-upscale-factor-0-25: SUCCESS (3.466s)
[403.366200] [114/155] (618s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[403.467756] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[403.472218] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[403.575737] [115/155] (618s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[403.666041] Starting subtest: plane-all-modeset-transition-internal-panels
[403.668284] Starting dynamic subtest: pipe-A-eDP-1
[404.984382] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.317s)
[405.265424] Starting dynamic subtest: pipe-B-eDP-1
[406.281554] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.025s)
[406.550788] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.883s)
[407.369986] [116/155] (614s left) gem_exec_schedule (preempt-engines)
[407.439391] Starting subtest: preempt-engines
[407.441263] Starting dynamic subtest: rcs0
[409.672256] Dynamic subtest rcs0: SUCCESS (2.240s)
[409.685022] Starting dynamic subtest: bcs0
[411.893673] Dynamic subtest bcs0: SUCCESS (2.219s)
[411.907990] Starting dynamic subtest: vcs0
[414.172447] Dynamic subtest vcs0: SUCCESS (2.276s)
[414.191303] Starting dynamic subtest: vcs1
[416.470502] Dynamic subtest vcs1: SUCCESS (2.297s)
[416.482612] Starting dynamic subtest: vecs0
[418.753897] Dynamic subtest vecs0: SUCCESS (2.282s)
[418.768407] Starting dynamic subtest: ccs0
[421.102069] Dynamic subtest ccs0: SUCCESS (2.348s)
[421.104615] Subtest preempt-engines: SUCCESS (13.673s)
[421.404613] [117/155] (600s left) vgem_basic (bad-fence)
[421.447489] Starting subtest: bad-fence
[421.449682] Subtest bad-fence: SUCCESS (0.000s)
[421.502917] [118/155] (600s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[421.608137] Starting subtest: fbcpsr-tiling-linear
[428.174749] Subtest fbcpsr-tiling-linear: SUCCESS (6.571s)
[428.327994] [119/155] (594s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-pwrite)
[428.425769] Starting subtest: psrhdr-rgb565-draw-pwrite
[428.429935] Subtest psrhdr-rgb565-draw-pwrite: SKIP (0.000s)
[428.507681] [120/155] (593s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[428.608728] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[428.610928] Starting dynamic subtest: pipe-A-eDP-1
[428.633848] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[428.646809] Starting dynamic subtest: pipe-B-eDP-1
[428.668724] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[428.679439] Starting dynamic subtest: pipe-C-eDP-1
[428.702114] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[428.712400] Starting dynamic subtest: pipe-D-eDP-1
[428.734747] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[428.738857] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[430.858175] [121/155] (591s left) kms_atomic_interruptible (legacy-dpms)
[430.949918] Starting subtest: legacy-dpms
[430.952238] Starting dynamic subtest: pipe-A-eDP-1
[438.366399] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.416s)
[438.368575] Subtest legacy-dpms: SUCCESS (7.417s)
[439.172517] [122/155] (583s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[439.231230] Starting subtest: x-tiled-to-vebox-y-tiled
[439.235723] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[439.428610] [123/155] (583s left) sw_sync (sync_merge)
[439.465557] Starting subtest: sync_merge
[439.467712] Subtest sync_merge: SUCCESS (0.000s)
[439.526429] [124/155] (583s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-render)
[439.626579] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-render
[439.630849] Subtest hdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[439.758795] [125/155] (582s left) gem_exec_reloc (basic-cpu-read-active)
[439.815188] Subtest basic-cpu-read-active: SKIP (0.000s)
[439.893286] [126/155] (582s left) gem_exec_balancer (persistence)
[440.165944] Starting subtest: persistence
[441.109669] Subtest persistence: SUCCESS (0.943s)
[441.233550] [127/155] (581s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[441.327508] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[441.329746] Starting dynamic subtest: pipe-A-eDP-1
[441.425787] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[441.437842] Starting dynamic subtest: pipe-B-eDP-1
[442.609696] Dynamic subtest pipe-B-eDP-1: SKIP (1.182s)
[442.614346] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.284s)
[443.859487] [128/155] (578s left) kms_panel_fitting (legacy)
[443.960790] Starting subtest: legacy
[443.962978] Starting dynamic subtest: pipe-A-eDP-1
[444.482605] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.523s)
[444.511404] Starting dynamic subtest: pipe-B-eDP-1
[446.045241] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.542s)
[446.073917] Starting dynamic subtest: pipe-C-eDP-1
[447.539517] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.474s)
[447.568467] Starting dynamic subtest: pipe-D-eDP-1
[449.037156] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.478s)
[449.039483] Subtest legacy: SUCCESS (5.077s)
[450.258590] [129/155] (572s left) syncobj_wait (multi-wait-signaled)
[450.327196] Starting subtest: multi-wait-signaled
[450.329115] Subtest multi-wait-signaled: SUCCESS (0.000s)
[450.436446] [130/155] (572s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move)
[450.537845] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move
[450.542388] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[450.628715] [131/155] (572s left) gem_mmap (bad-offset)
[450.675733] Subtest bad-offset: SKIP (0.000s)
[450.734632] [132/155] (572s left) kms_addfb_basic (invalid-get-prop-any)
[450.793956] Starting subtest: invalid-get-prop-any
[450.796167] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[450.921036] [133/155] (572s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[450.974781] Starting subtest: yf-tiled-to-vebox-y-tiled
[450.979385] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[451.164356] [134/155] (571s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[451.272061] Starting subtest: x-tiled-16bpp-rotate-0
[452.631282] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.357s)
[452.750184] [135/155] (570s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[452.879309] Starting subtest: flip-vs-cursor-atomic
[460.484421] Subtest flip-vs-cursor-atomic: SUCCESS (7.603s)
[461.376705] [136/155] (561s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[461.470332] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[461.472609] Starting dynamic subtest: pipe-A-default-mode
[464.165880] Dynamic subtest pipe-A-default-mode: SUCCESS (2.695s)
[464.168146] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.697s)
[464.989874] [137/155] (558s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[465.110213] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[465.114361] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[465.191622] [138/155] (558s left) drm_read (short-buffer-block)
[465.340762] Starting subtest: short-buffer-block
[465.343177] Subtest short-buffer-block: SUCCESS (0.000s)
[465.455725] [139/155] (557s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[465.558846] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[472.942490] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.388s)
[473.093579] [140/155] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[473.201957] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[473.206267] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[473.318643] [141/155] (550s left) perf_pmu (init-wait)
[473.359996] Starting subtest: init-wait
[473.362900] Starting dynamic subtest: rcs0
[473.365400] Dynamic subtest rcs0: SUCCESS (0.002s)
[473.376933] Starting dynamic subtest: bcs0
[473.378890] Dynamic subtest bcs0: SUCCESS (0.000s)
[473.389609] Starting dynamic subtest: vcs0
[473.391552] Dynamic subtest vcs0: SUCCESS (0.001s)
[473.402977] Starting dynamic subtest: vcs1
[473.405240] Dynamic subtest vcs1: SUCCESS (0.000s)
[473.416234] Starting dynamic subtest: vecs0
[473.418100] Dynamic subtest vecs0: SUCCESS (0.001s)
[473.428603] Starting dynamic subtest: ccs0
[473.430487] Dynamic subtest ccs0: SUCCESS (0.000s)
[473.432370] Subtest init-wait: SUCCESS (0.009s)
[473.475800] [142/155] (549s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[473.590585] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[473.594763] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[473.697620] [143/155] (549s left) gem_exec_whisper (basic-fds-all)
[473.771038] Starting subtest: basic-fds-all
[485.164797] Subtest basic-fds-all: SUCCESS (11.387s)
[485.356391] [144/155] (538s left) kms_big_fb (4-tiled-addfb-size-overflow)
[485.465821] Starting subtest: 4-tiled-addfb-size-overflow
[485.468144] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[485.565015] [145/155] (538s left) kms_pm_rpm (fences-dpms)
[487.388604] Starting subtest: fences-dpms
[487.394059] Subtest fences-dpms: SKIP (0.000s)
[487.874184] [146/155] (535s left) i915_suspend (debugfs-reader)
[487.935688] Starting subtest: debugfs-reader
[506.023806] Subtest debugfs-reader: SUCCESS (3.158s)
[506.167044] [147/155] (517s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[506.569566] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[507.435925] [148/155] (516s left) kms_prop_blob (invalid-get-prop)
[507.490232] Starting subtest: invalid-get-prop
[507.492179] Subtest invalid-get-prop: SUCCESS (0.000s)
[507.605820] [149/155] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[507.703915] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[507.708043] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[507.820748] [150/155] (516s left) gem_exec_params (invalid-bsd2-flag-on-render)
[507.879432] Starting subtest: invalid-bsd2-flag-on-render
[507.881702] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[507.992258] [151/155] (515s left) gem_exec_balancer (invalid-bonds)
[508.054495] Starting subtest: invalid-bonds
[508.059132] Subtest invalid-bonds: SKIP (0.000s)
[508.382033] [152/155] (515s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[508.473591] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[508.475969] Starting dynamic subtest: pipe-A-eDP-1
[510.734150] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.242s)
[510.745165] Starting dynamic subtest: pipe-B-eDP-1
[513.140224] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.389s)
[513.151588] Starting dynamic subtest: pipe-C-eDP-1
[515.320205] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.168s)
[515.332007] Starting dynamic subtest: pipe-D-eDP-1
[517.529910] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.199s)
[517.532017] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.003s)
[518.734272] [153/155] (505s left) gem_mmap_gtt (flink-race)
[518.800365] Subtest flink-race: SKIP (0.000s)
[518.871621] [154/155] (505s left) kms_psr (psr-primary-blt)
[518.957472] Starting subtest: psr-primary-blt
[518.959948] Starting dynamic subtest: eDP-1
[520.710689] Dynamic subtest eDP-1: SUCCESS (1.747s)
[520.713000] Subtest psr-primary-blt: SUCCESS (1.748s)
[521.537554] [155/155] (502s left) kms_sequence (get-idle)
[521.641431] Starting subtest: get-idle
[521.643705] Starting dynamic subtest: pipe-A-eDP-1
[523.447020] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s)
[523.459353] Starting dynamic subtest: pipe-B-eDP-1
[525.993081] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.540s)
[526.004810] Starting dynamic subtest: pipe-C-eDP-1
[528.483984] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.487s)
[528.496320] Starting dynamic subtest: pipe-D-eDP-1
[530.977510] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.488s)
[530.979847] Subtest get-idle: SUCCESS (9.322s)
[531.854582] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_pxp
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: drm_mm
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_gtt_cpu_tlb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_properties
results: parsing output: 17/ for test: kms_async_flips
results: parsing output: 18/ for test: gem_spin_batch
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_chamelium_audio
results: parsing output: 22/ for test: kms_plane
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_lease
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_debugfs
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: kms_vblank
results: parsing output: 31/ for test: i915_pciid
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_chamelium_frames
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_linear_blits
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_invalid_mode
results: parsing output: 39/ for test: gem_vm_create
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_ccs
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_pipe_crc_basic
results: parsing output: 49/ for test: kms_color
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_content_protection
results: parsing output: 52/ for test: gem_mmap_wc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_create
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_sync
results: parsing output: 60/ for test: gem_unref_active_buffers
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_rotation_crc
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_rotation_crc
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_addfb_basic
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_fence
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_request_retire
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_ctx_isolation
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gen9_exec_parse
results: parsing output: 84/ for test: gem_lmem_swapping
results: parsing output: 85/ for test: kms_force_connector_basic
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_dsc
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: i915_pm_rpm
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: sriov_basic
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: gem_sync
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: kms_addfb_basic
results: parsing output: 103/ for test: prime_mmap
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: syncobj_basic
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_atomic_transition
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: vgem_basic
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_atomic_interruptible
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: sw_sync
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_panel_fitting
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_mmap
results: parsing output: 131/ for test: kms_addfb_basic
results: parsing output: 132/ for test: gem_render_copy
results: parsing output: 133/ for test: kms_big_fb
results: parsing output: 134/ for test: kms_cursor_legacy
results: parsing output: 135/ for test: kms_flip_scaled_crc
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: drm_read
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: perf_pmu
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: gem_exec_whisper
results: parsing output: 143/ for test: kms_big_fb
results: parsing output: 144/ for test: kms_pm_rpm
results: parsing output: 145/ for test: i915_suspend
results: parsing output: 146/ for test: kms_chamelium_hpd
results: parsing output: 147/ for test: kms_prop_blob
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_exec_params
results: parsing output: 150/ for test: gem_exec_balancer
results: parsing output: 151/ for test: kms_ccs
results: parsing output: 152/ for test: gem_mmap_gtt
results: parsing output: 153/ for test: kms_psr
results: parsing output: 154/ for test: kms_sequence
Done.