[56.671738] Initializing watchdogs
[56.671806]   /dev/watchdog0
[56.687266] [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.692085] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.694628] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.698170] [001/156] (960s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[56.815863] Starting subtest: fbc-psr2-primary-mmap-cpu
[56.817780] Starting dynamic subtest: eDP-1
[56.821965] Dynamic subtest eDP-1: SKIP (0.000s)
[56.826274] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[56.888139] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[56.984298] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[63.863100] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.886s)
[63.984288] [003/156] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[64.097795] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[70.977084] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.884s)
[71.084725] [004/156] (946s left) gem_pxp (hw-rejects-pxp-buffer)
[71.217572] Starting subtest: hw-rejects-pxp-buffer
[71.221810] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[71.330926] [005/156] (946s left) syncobj_timeline (multi-wait-for-submit-signaled)
[71.382939] Starting subtest: multi-wait-for-submit-signaled
[71.385361] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[71.504867] [006/156] (945s left) i915_pm_rps (reset)
[71.560712] Starting subtest: reset
[79.999316] Subtest reset: SUCCESS (8.437s)
[80.125911] [007/156] (937s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-render)
[80.236470] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-render
[80.240755] Subtest hdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[80.332943] [008/156] (937s left) perf (missing-sample-flags)
[80.456718] Starting subtest: missing-sample-flags
[80.458911] Subtest missing-sample-flags: SUCCESS (0.000s)
[80.496852] [009/156] (937s left) gem_ctx_shared (exec-single-timeline)
[80.559490] Starting subtest: exec-single-timeline
[80.561823] Starting dynamic subtest: rcs0
[81.626382] Dynamic subtest rcs0: SUCCESS (1.065s)
[81.637590] Starting dynamic subtest: bcs0
[82.715559] Dynamic subtest bcs0: SUCCESS (1.087s)
[82.728677] Starting dynamic subtest: vcs0
[83.805782] Dynamic subtest vcs0: SUCCESS (1.089s)
[83.817790] Starting dynamic subtest: vcs1
[84.890896] Dynamic subtest vcs1: SUCCESS (1.084s)
[84.904656] Starting dynamic subtest: vecs0
[85.979500] Dynamic subtest vecs0: SUCCESS (1.087s)
[85.993862] Starting dynamic subtest: ccs0
[87.068328] Dynamic subtest ccs0: SUCCESS (1.087s)
[87.071068] Subtest exec-single-timeline: SUCCESS (6.509s)
[87.255147] [010/156] (930s left) prime_vgem (sync)
[87.408031] Starting subtest: sync
[87.410527] Starting dynamic subtest: rcs0
[87.450023] Dynamic subtest rcs0: SUCCESS (0.042s)
[87.458995] Starting dynamic subtest: bcs0
[87.516370] Dynamic subtest bcs0: SUCCESS (0.066s)
[87.524853] Starting dynamic subtest: vcs0
[87.565236] Dynamic subtest vcs0: SUCCESS (0.048s)
[87.573721] Starting dynamic subtest: vcs1
[87.612305] Dynamic subtest vcs1: SUCCESS (0.047s)
[87.620752] Starting dynamic subtest: vecs0
[87.659557] Dynamic subtest vecs0: SUCCESS (0.047s)
[87.668185] Starting dynamic subtest: ccs0
[87.706068] Dynamic subtest ccs0: SUCCESS (0.046s)
[87.708578] Subtest sync: SUCCESS (0.299s)
[87.818699] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[87.822608] [011/156] (929s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[87.928403] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[87.930837] Starting dynamic subtest: pipe-A-eDP-1
[94.617139] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.693s)
[94.628037] Starting dynamic subtest: pipe-B-eDP-1
[101.667303] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.048s)
[101.669505] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.743s)
[102.549612] [012/156] (915s left) kms_addfb_basic (bad-pitch-65536)
[102.610106] Starting subtest: bad-pitch-65536
[102.612074] Subtest bad-pitch-65536: SUCCESS (0.000s)
[102.757732] [013/156] (914s left) kms_plane (pixel-format-4-tiled-modifier)
[102.851388] Starting subtest: pixel-format-4-tiled-modifier
[102.875491] Starting dynamic subtest: pipe-A-plane-0
[103.299402] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[103.309837] Starting dynamic subtest: pipe-A-plane-3
[103.652897] Dynamic subtest pipe-A-plane-3: SUCCESS (0.355s)
[103.661237] Starting dynamic subtest: pipe-A-plane-5
[103.665035] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[104.743299] Starting dynamic subtest: pipe-B-plane-0
[105.134576] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[105.144095] Starting dynamic subtest: pipe-B-plane-3
[105.457049] Dynamic subtest pipe-B-plane-3: SUCCESS (0.322s)
[105.466091] Starting dynamic subtest: pipe-B-plane-5
[105.470094] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[105.773055] Subtest pixel-format-4-tiled-modifier: SUCCESS (2.924s)
[106.618581] [014/156] (911s left) api_intel_allocator (two-level-inception)
[106.683073] Starting subtest: two-level-inception
[112.134439] Subtest two-level-inception: SUCCESS (5.400s)
[112.215742] [015/156] (905s left) gem_ctx_persistence (legacy-engines-mixed-process)
[112.285108] Starting subtest: legacy-engines-mixed-process
[112.287550] Starting dynamic subtest: render
[114.336176] Dynamic subtest render: SUCCESS (2.050s)
[114.348810] Starting dynamic subtest: bsd1
[116.278319] Dynamic subtest bsd1: SUCCESS (1.941s)
[116.288180] Starting dynamic subtest: bsd2
[118.283841] Dynamic subtest bsd2: SUCCESS (2.004s)
[118.296757] Starting dynamic subtest: blt
[120.236993] Dynamic subtest blt: SUCCESS (1.950s)
[120.245776] Starting dynamic subtest: vebox
[122.320762] Dynamic subtest vebox: SUCCESS (2.084s)
[122.323278] Subtest legacy-engines-mixed-process: SUCCESS (10.036s)
[122.408190] [016/156] (895s left) kms_atomic_interruptible (universal-setplane-cursor)
[122.498977] Starting subtest: universal-setplane-cursor
[122.501324] Starting dynamic subtest: pipe-A-eDP-1
[129.939961] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.439s)
[129.942368] Subtest universal-setplane-cursor: SUCCESS (7.440s)
[130.788698] [017/156] (887s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[130.891522] Starting subtest: fbc-modesetfrombusy
[134.745650] Subtest fbc-modesetfrombusy: SUCCESS (3.863s)
[135.921987] [018/156] (881s left) gem_softpin (evict-active)
[135.990391] Starting subtest: evict-active
[135.994072] Subtest evict-active: SUCCESS (0.006s)
[136.122443] [019/156] (881s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[136.224010] Starting subtest: extended-pageflip-modeset-hang-oldfb
[136.226235] Starting dynamic subtest: pipe-A
[144.146078] Dynamic subtest pipe-A: SUCCESS (7.921s)
[144.157566] Starting dynamic subtest: pipe-D
[152.741894] Dynamic subtest pipe-D: SUCCESS (8.592s)
[152.744319] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.518s)
[153.583560] [020/156] (864s left) kms_hdr (bpc-switch-dpms)
[153.684942] Starting subtest: bpc-switch-dpms
[153.687142] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[159.291887] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.608s)
[159.302941] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[164.873526] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (5.579s)
[164.875987] Subtest bpc-switch-dpms: SUCCESS (11.190s)
[164.998412] [021/156] (853s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[165.093183] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[165.097478] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[165.180692] [022/156] (852s left) gem_huc_copy (huc-copy)
[165.240443] Starting subtest: huc-copy
[165.242361] Subtest huc-copy: SUCCESS (0.004s)
[165.380250] [023/156] (852s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[165.491894] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[170.145453] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.660s)
[171.339782] [024/156] (846s left) i915_drm_fdinfo (virtual-idle)
[171.382925] Starting subtest: virtual-idle
[174.442603] Subtest virtual-idle: SUCCESS (3.057s)
[174.531246] [025/156] (843s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[174.639804] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[174.641967] Starting dynamic subtest: pipe-A-eDP-1
[174.662071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[174.672164] Starting dynamic subtest: pipe-B-eDP-1
[174.691291] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[174.699534] Starting dynamic subtest: pipe-C-eDP-1
[174.718294] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[174.726644] Starting dynamic subtest: pipe-D-eDP-1
[174.746066] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[174.747989] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[176.876017] [026/156] (841s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[176.974214] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[179.473378] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.506s)
[180.602106] [027/156] (837s left) syncobj_timeline (wait-all-for-submit-complex)
[180.661612] Starting subtest: wait-all-for-submit-complex
[180.875045] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[180.950039] [028/156] (837s left) gem_mmap_gtt (basic-short)
[181.006734] Subtest basic-short: SKIP (0.000s)
[181.062266] [029/156] (837s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[181.118800] Starting subtest: etime-multi-wait-all-available-unsubmitted
[181.226043] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.106s)
[181.302617] [030/156] (837s left) kms_pm_dc (dc5-dpms)
[182.397604] Starting subtest: dc5-dpms
[184.451357] Subtest dc5-dpms: SUCCESS (2.054s)
[184.528967] [031/156] (833s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[184.621759] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[184.626270] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[184.714265] [032/156] (833s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[184.816075] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[184.820066] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[184.914532] [033/156] (833s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[185.011797] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[185.016309] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[186.152584] [034/156] (832s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[186.253820] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[186.258429] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[186.362401] [035/156] (832s left) kms_cursor_crc (cursor-offscreen-512x170)
[186.669078] Starting subtest: cursor-offscreen-512x170
[186.673354] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[186.825178] [036/156] (831s left) kms_flip (plain-flip-fb-recreate-interruptible)
[186.926739] Starting subtest: plain-flip-fb-recreate-interruptible
[186.928992] Starting dynamic subtest: A-eDP1
[195.822334] Dynamic subtest A-eDP1: SUCCESS (8.896s)
[195.833551] Starting dynamic subtest: B-eDP1
[204.655215] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[204.666088] Starting dynamic subtest: C-eDP1
[213.467345] Dynamic subtest C-eDP1: SUCCESS (8.811s)
[213.476118] Starting dynamic subtest: D-eDP1
[222.297206] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[222.301386] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.376s)
[223.491181] [037/156] (795s left) gem_busy (parallel)
[223.667516] Starting subtest: parallel
[223.670428] Starting dynamic subtest: rcs0
[225.280104] Dynamic subtest rcs0: SUCCESS (1.611s)
[225.293353] Starting dynamic subtest: bcs0
[227.263726] Dynamic subtest bcs0: SUCCESS (1.981s)
[227.275486] Starting dynamic subtest: vcs0
[229.363290] Dynamic subtest vcs0: SUCCESS (2.044s)
[229.373819] Starting dynamic subtest: vcs1
[231.294852] Dynamic subtest vcs1: SUCCESS (1.982s)
[231.307435] Starting dynamic subtest: vecs0
[233.330206] Dynamic subtest vecs0: SUCCESS (1.981s)
[233.341604] Starting dynamic subtest: ccs0
[235.328846] Dynamic subtest ccs0: SUCCESS (2.045s)
[235.331902] Subtest parallel: SUCCESS (11.659s)
[235.555451] [038/156] (783s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[235.672120] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[235.676126] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[235.770874] [039/156] (783s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[235.867956] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[235.870165] Starting dynamic subtest: pipe-A
[236.205217] Dynamic subtest pipe-A: SUCCESS (0.339s)
[236.214675] Starting dynamic subtest: pipe-B
[237.674198] Dynamic subtest pipe-B: SUCCESS (1.468s)
[237.683868] Starting dynamic subtest: pipe-C
[239.131588] Dynamic subtest pipe-C: SUCCESS (1.456s)
[239.141234] Starting dynamic subtest: pipe-D
[240.559764] Dynamic subtest pipe-D: SUCCESS (1.426s)
[240.562269] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.695s)
[241.735403] [040/156] (777s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[241.784436] Starting subtest: multi-wait-all-available-submitted-signaled
[241.786797] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[241.868381] [041/156] (776s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[241.963232] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[241.967618] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[242.052361] [042/156] (776s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-pwrite)
[242.159129] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-pwrite
[242.163229] Subtest hdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[242.249791] [043/156] (776s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[242.334265] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[242.346216] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[242.431430] [044/156] (776s left) syncobj_basic (bad-flags-handle-to-fd)
[242.486786] Starting subtest: bad-flags-handle-to-fd
[242.489263] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[242.580254] [045/156] (776s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[242.636356] Starting subtest: map-fixed-invalidate-overlap-busy
[242.640607] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[242.768867] [046/156] (776s left) kms_lease (lease-unleased-crtc)
[242.863356] Starting subtest: lease-unleased-crtc
[242.865234] Starting dynamic subtest: pipe-A-eDP-1
[243.150856] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[243.160976] Starting dynamic subtest: pipe-B-eDP-1
[243.872220] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.719s)
[243.885815] Starting dynamic subtest: pipe-C-eDP-1
[243.888049] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[243.896856] Starting dynamic subtest: pipe-D-eDP-1
[243.899248] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[243.901430] Subtest lease-unleased-crtc: SUCCESS (1.022s)
[244.286439] [047/156] (774s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[244.339520] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[244.341716] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[244.437995] [048/156] (774s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[244.526943] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[244.529317] Starting dynamic subtest: pipe-A-eDP-1
[244.552313] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[244.563308] Starting dynamic subtest: pipe-B-eDP-1
[244.585391] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[244.594401] Starting dynamic subtest: pipe-C-eDP-1
[244.616205] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[244.626509] Starting dynamic subtest: pipe-D-eDP-1
[244.648684] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[244.652760] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[246.845438] [049/156] (772s left) gem_flink_basic (bad-open)
[246.895848] Starting subtest: bad-open
[246.897956] Subtest bad-open: SUCCESS (0.000s)
[247.014762] [050/156] (772s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[247.116627] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[247.120724] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[247.210345] [051/156] (772s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[247.295086] Starting subtest: drrs-dirtyfb-ioctl
[247.307740] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[247.392381] [052/156] (771s left) gem_userptr_blits (create-destroy-unsync)
[247.459035] Subtest create-destroy-unsync: SKIP (0.000s)
[247.579838] [053/156] (771s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[247.681592] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[247.685803] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[247.772164] [054/156] (771s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[247.872790] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[247.876482] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[247.968900] [055/156] (771s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[248.068067] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[248.071534] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[248.172663] [056/156] (771s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[248.271614] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[248.274894] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[248.366999] [057/156] (771s left) gem_spin_batch (legacy-resubmit)
[248.420163] Starting subtest: legacy-resubmit
[248.422240] Starting dynamic subtest: default
[248.426737] Dynamic subtest default: SUCCESS (0.006s)
[248.436361] Starting dynamic subtest: render
[248.438397] Dynamic subtest render: SUCCESS (0.001s)
[248.447158] Starting dynamic subtest: bsd
[248.448768] Dynamic subtest bsd: SUCCESS (0.002s)
[248.456753] Starting dynamic subtest: bsd1
[248.458358] Dynamic subtest bsd1: SUCCESS (0.001s)
[248.466521] Starting dynamic subtest: bsd2
[248.468194] Dynamic subtest bsd2: SUCCESS (0.003s)
[248.476293] Starting dynamic subtest: blt
[248.477939] Dynamic subtest blt: SUCCESS (0.003s)
[248.486200] Starting dynamic subtest: vebox
[248.487803] Dynamic subtest vebox: SUCCESS (0.003s)
[248.489432] Subtest legacy-resubmit: SUCCESS (0.025s)
[248.664181] [058/156] (770s left) gem_exec_whisper (basic-fds)
[248.731495] Starting subtest: basic-fds
[256.622078] Subtest basic-fds: SUCCESS (7.887s)
[256.808760] [059/156] (762s left) kms_frontbuffer_tracking (fbcpsrhdr-stridechange)
[256.905026] Starting subtest: fbcpsrhdr-stridechange
[256.909255] Subtest fbcpsrhdr-stridechange: SKIP (0.000s)
[257.023700] [060/156] (762s left) kms_flip (2x-modeset-vs-vblank-race)
[257.121278] Starting subtest: 2x-modeset-vs-vblank-race
[257.133254] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[257.213318] [061/156] (762s left) gem_ctx_param (get-priority-new-ctx)
[257.266841] Starting subtest: get-priority-new-ctx
[257.269199] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[257.383164] [062/156] (762s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen)
[257.488199] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen
[257.492136] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[257.600256] [063/156] (762s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[257.702301] Starting subtest: psr2-cursor-plane-move-continuous-sf
[257.704497] Starting dynamic subtest: pipe-A-eDP-1
[268.042063] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.343s)
[268.053521] Starting dynamic subtest: pipe-B-eDP-1
[279.105501] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.062s)
[279.107936] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.408s)
[280.002433] [064/156] (739s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[280.107943] Starting subtest: fbc-psr-sprite-mmap-gtt
[280.110308] Starting dynamic subtest: eDP-1
[280.114878] Dynamic subtest eDP-1: SKIP (0.000s)
[280.119604] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[280.194164] [065/156] (739s left) gem_vm_create (create-ext)
[280.249094] Starting subtest: create-ext
[280.254371] Subtest create-ext: SUCCESS (0.005s)
[280.370268] [066/156] (739s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[280.456067] Starting subtest: coverage-vs-premult-vs-constant
[280.759644] Starting dynamic subtest: pipe-A-eDP-1
[281.380769] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.621s)
[281.392230] Starting dynamic subtest: pipe-D-eDP-1
[282.730703] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s)
[282.733089] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.274s)
[283.570658] [067/156] (736s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[283.667016] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[283.671519] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[283.766880] [068/156] (736s left) gem_exec_reloc (basic-cpu-read-active)
[283.834279] Subtest basic-cpu-read-active: SKIP (0.000s)
[283.907975] [069/156] (736s left) kms_sequence (queue-idle)
[284.002100] Starting subtest: queue-idle
[284.004377] Starting dynamic subtest: pipe-A-eDP-1
[285.808730] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.805s)
[285.821114] Starting dynamic subtest: pipe-B-eDP-1
[288.329566] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.520s)
[288.339322] Starting dynamic subtest: pipe-C-eDP-1
[290.757306] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.426s)
[290.767480] Starting dynamic subtest: pipe-D-eDP-1
[293.199392] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.441s)
[293.201617] Subtest queue-idle: SUCCESS (9.198s)
[294.009059] [070/156] (726s left) kms_scaling_modes (scaling-mode-full-aspect)
[294.108160] Starting subtest: scaling-mode-full-aspect
[294.110547] Starting dynamic subtest: pipe-A-eDP-1
[294.204447] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.098s)
[294.214383] Starting dynamic subtest: pipe-B-eDP-1
[295.348162] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s)
[295.358768] Starting dynamic subtest: pipe-C-eDP-1
[296.479904] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s)
[296.492130] Starting dynamic subtest: pipe-D-eDP-1
[297.606142] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[297.608327] Subtest scaling-mode-full-aspect: SUCCESS (3.501s)
[298.769666] [071/156] (721s left) kms_big_fb (linear-64bpp-rotate-270)
[298.882761] Starting subtest: linear-64bpp-rotate-270
[298.902565] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[299.035266] [072/156] (721s left) kms_cursor_crc (cursor-sliding-128x42)
[299.272743] Starting subtest: cursor-sliding-128x42
[299.320932] Subtest cursor-sliding-128x42: SKIP (0.044s)
[299.527141] [073/156] (720s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[299.630960] Starting subtest: 4-tiled-16bpp-rotate-180
[300.944073] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.312s)
[301.070123] [074/156] (719s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[301.177371] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[301.180813] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[301.296936] [075/156] (719s left) gem_mmap_gtt (flink-race)
[301.357063] Subtest flink-race: SKIP (0.000s)
[301.415837] [076/156] (718s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[301.795844] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[302.587705] [077/156] (717s left) api_intel_bb (simple-bb-ctx)
[302.638411] Starting subtest: simple-bb-ctx
[302.645668] Subtest simple-bb-ctx: SUCCESS (0.009s)
[302.769585] [078/156] (717s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[302.880157] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[302.884270] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[302.998536] [079/156] (717s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[303.097737] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[303.101860] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[303.186446] [080/156] (717s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[303.288873] Starting subtest: yf-tiled-16bpp-rotate-90
[303.293205] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[303.377114] [081/156] (717s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[303.475675] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[303.479920] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[303.578231] [082/156] (717s left) syncobj_wait (wait-for-submit-complex)
[303.627583] Starting subtest: wait-for-submit-complex
[303.689457] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[303.764901] [083/156] (716s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[303.857558] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[303.861241] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[303.958948] [084/156] (716s left) testdisplay
[304.256803] [085/156] (716s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[304.359806] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[304.363173] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[304.444758] [086/156] (716s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[304.526077] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[304.527910] Starting dynamic subtest: pipe-A
[304.589249] Dynamic subtest pipe-A: SUCCESS (0.065s)
[304.600488] Starting dynamic subtest: pipe-B
[305.714048] Dynamic subtest pipe-B: SUCCESS (1.123s)
[305.725799] Starting dynamic subtest: pipe-C
[306.841456] Dynamic subtest pipe-C: SUCCESS (1.126s)
[306.851340] Starting dynamic subtest: pipe-D
[307.971157] Dynamic subtest pipe-D: SUCCESS (1.128s)
[307.973392] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.447s)
[309.140157] [087/156] (711s left) gem_exec_schedule (preempt)
[309.208349] Starting subtest: preempt
[309.210654] Starting dynamic subtest: rcs0
[309.224425] Dynamic subtest rcs0: SUCCESS (0.024s)
[309.234560] Starting dynamic subtest: bcs0
[309.245166] Dynamic subtest bcs0: SUCCESS (0.020s)
[309.254596] Starting dynamic subtest: vcs0
[309.266815] Dynamic subtest vcs0: SUCCESS (0.021s)
[309.276326] Starting dynamic subtest: vcs1
[309.287501] Dynamic subtest vcs1: SUCCESS (0.020s)
[309.296978] Starting dynamic subtest: vecs0
[309.310619] Dynamic subtest vecs0: SUCCESS (0.022s)
[309.320194] Starting dynamic subtest: ccs0
[309.334529] Dynamic subtest ccs0: SUCCESS (0.023s)
[309.336787] Subtest preempt: SUCCESS (0.134s)
[311.369228] [088/156] (709s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu)
[311.469992] Starting subtest: fbchdr-rgb565-draw-mmap-cpu
[311.474418] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[311.560355] [089/156] (709s left) gem_exec_params (invalid-bsd-ring)
[311.605519] Starting subtest: invalid-bsd-ring
[311.607963] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[311.709504] [090/156] (709s left) kms_psr (psr-primary-blt)
[311.798044] Starting subtest: psr-primary-blt
[311.800365] Starting dynamic subtest: eDP-1
[313.521604] Dynamic subtest eDP-1: SUCCESS (1.724s)
[313.523772] Subtest psr-primary-blt: SUCCESS (1.725s)
[314.379635] [091/156] (706s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[314.431493] Subtest untiled-to-tiled: SKIP (0.000s)
[314.513822] [092/156] (706s left) gem_ctx_persistence (file)
[314.563437] Starting subtest: file
[314.688396] Subtest file: SUCCESS (0.125s)
[314.812833] [093/156] (706s left) gem_exec_params (sol-reset-invalid)
[314.870245] Starting subtest: sol-reset-invalid
[314.876344] Subtest sol-reset-invalid: SUCCESS (0.003s)
[316.330643] [094/156] (704s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[316.443664] Starting subtest: y-tiled-16bpp-rotate-0
[316.448162] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[316.542504] [095/156] (704s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[316.642853] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[316.646991] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[316.742341] [096/156] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[316.845190] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[323.567055] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.725s)
[323.708816] [097/156] (697s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[323.800292] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[323.804257] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[323.882459] [098/156] (697s left) gem_exec_reloc (basic-cpu-gtt)
[323.940432] Subtest basic-cpu-gtt: SKIP (0.000s)
[324.020901] [099/156] (697s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[324.123993] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[330.987284] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.868s)
[331.124981] [100/156] (690s left) kms_color (ctm-red-to-blue)
[331.218804] Starting subtest: ctm-red-to-blue
[331.221084] Starting dynamic subtest: pipe-A-eDP-1
[331.928947] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[331.940276] Starting dynamic subtest: pipe-B-eDP-1
[333.412781] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s)
[333.422312] Starting dynamic subtest: pipe-C-eDP-1
[334.760255] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.348s)
[334.772099] Starting dynamic subtest: pipe-D-eDP-1
[336.096267] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[336.098699] Subtest ctm-red-to-blue: SUCCESS (4.879s)
[336.903533] [101/156] (684s left) kms_psr (psr2-dpms)
[337.006975] Starting subtest: psr2-dpms
[337.010266] Starting dynamic subtest: eDP-1
[340.034592] Dynamic subtest eDP-1: SUCCESS (3.026s)
[340.036884] Subtest psr2-dpms: SUCCESS (3.027s)
[340.908491] [102/156] (680s left) kms_lease (atomic-implicit-crtc)
[341.013906] Starting subtest: atomic-implicit-crtc
[341.016166] Starting dynamic subtest: pipe-A-eDP-1
[341.027238] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[341.037088] Starting dynamic subtest: pipe-B-eDP-1
[341.048385] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[341.057818] Starting dynamic subtest: pipe-C-eDP-1
[341.068685] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[341.077397] Starting dynamic subtest: pipe-D-eDP-1
[341.088222] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[341.090460] Subtest atomic-implicit-crtc: SUCCESS (0.037s)
[341.145424] [103/156] (680s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt)
[341.251983] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt
[341.256151] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[341.359098] [104/156] (680s left) gem_pread (display)
[341.426308] Subtest display: SKIP (0.000s)
[341.487600] [105/156] (680s left) syncobj_basic (bad-handle-to-fd)
[341.551598] Starting subtest: bad-handle-to-fd
[341.553734] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[341.684993] [106/156] (679s left) i915_drm_fdinfo (memory-info-idle)
[341.724226] Starting subtest: memory-info-idle
[341.726636] Starting dynamic subtest: smem0
[341.768540] Dynamic subtest smem0: SUCCESS (0.046s)
[341.770811] Subtest memory-info-idle: SUCCESS (0.048s)
[341.844041] [107/156] (679s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[341.941447] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[341.944914] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[342.033173] [108/156] (679s left) i915_query (query-topology-garbage-items)
[342.084533] Starting subtest: query-topology-garbage-items
[342.086178] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[342.184447] [109/156] (679s left) perf_pmu (busy-start)
[342.225981] Starting subtest: busy-start
[342.227931] Starting dynamic subtest: rcs0
[344.777996] Dynamic subtest rcs0: SUCCESS (2.551s)
[344.790833] Starting dynamic subtest: bcs0
[347.350719] Dynamic subtest bcs0: SUCCESS (2.549s)
[347.363258] Starting dynamic subtest: vcs0
[351.293673] Dynamic subtest vcs0: SUCCESS (3.961s)
[351.306557] Starting dynamic subtest: vcs1
[355.325371] Dynamic subtest vcs1: SUCCESS (4.029s)
[355.339604] Starting dynamic subtest: vecs0
[359.293240] Dynamic subtest vecs0: SUCCESS (3.966s)
[359.304061] Starting dynamic subtest: ccs0
[361.864065] Dynamic subtest ccs0: SUCCESS (2.548s)
[361.866534] Subtest busy-start: SUCCESS (19.617s)
[361.969393] [110/156] (659s left) prime_vgem (fence-flip-hang)
[362.042389] Subtest fence-flip-hang: SKIP (0.000s)
[362.134925] [111/156] (659s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[362.241320] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[362.245806] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[362.334165] [112/156] (659s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[362.438886] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[362.442753] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[362.528858] [113/156] (659s left) kms_cursor_crc (cursor-sliding-64x64)
[362.704228] Starting subtest: cursor-sliding-64x64
[362.709664] Starting dynamic subtest: pipe-A-eDP-1
[365.941749] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.234s)
[365.972161] Starting dynamic subtest: pipe-D-eDP-1
[369.803414] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.836s)
[369.805677] Subtest cursor-sliding-64x64: SUCCESS (7.097s)
[370.683587] [114/156] (651s left) gem_ctx_bad_destroy (double-destroy)
[370.731947] Starting subtest: double-destroy
[370.734416] Subtest double-destroy: SUCCESS (0.000s)
[370.822728] [115/156] (651s left) kms_vrr (flip-suspend)
[370.912120] Starting subtest: flip-suspend
[370.918798] Subtest flip-suspend: SKIP (0.000s)
[370.985839] [116/156] (651s left) gem_exec_params (readonly)
[371.039572] Starting subtest: readonly
[371.041913] Subtest readonly: SUCCESS (0.002s)
[371.167789] [117/156] (650s left) gem_exec_schedule (preempt-self)
[371.246688] Starting subtest: preempt-self
[371.248728] Starting dynamic subtest: rcs0
[371.261276] Dynamic subtest rcs0: SUCCESS (0.023s)
[371.273653] Starting dynamic subtest: bcs0
[371.283441] Dynamic subtest bcs0: SUCCESS (0.021s)
[371.294574] Starting dynamic subtest: vcs0
[371.308437] Dynamic subtest vcs0: SUCCESS (0.024s)
[371.317969] Starting dynamic subtest: vcs1
[371.334914] Dynamic subtest vcs1: SUCCESS (0.025s)
[371.349020] Starting dynamic subtest: vecs0
[371.362645] Dynamic subtest vecs0: SUCCESS (0.027s)
[371.374589] Starting dynamic subtest: ccs0
[371.385657] Dynamic subtest ccs0: SUCCESS (0.022s)
[371.387992] Subtest preempt-self: SUCCESS (0.148s)
[373.424502] [118/156] (648s left) kms_chamelium_hpd (hdmi-hpd)
[373.808332] Subtest hdmi-hpd: SKIP (0.000s)
[374.587573] [119/156] (647s left) gem_exec_await (wide-contexts)
[374.807066] Starting subtest: wide-contexts
[398.247635] Subtest wide-contexts: SUCCESS (23.430s)
[398.445936] [120/156] (623s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[398.600818] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[405.401367] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.805s)
[405.527127] [121/156] (616s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[405.639280] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[405.643653] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[405.730470] [122/156] (616s left) sw_sync (sync_random_merge)
[405.775194] Starting subtest: sync_random_merge
[405.820605] Subtest sync_random_merge: SUCCESS (0.045s)
[405.894822] [123/156] (616s left) kms_content_protection (uevent-hdcp14)
[406.045276] Starting subtest: uevent-hdcp14
[406.049752] Subtest uevent-hdcp14: SKIP (0.000s)
[406.174940] [124/156] (616s left) gen9_exec_parse (bb-start-out)
[406.229733] Subtest bb-start-out: SKIP (0.000s)
[406.308696] [125/156] (616s left) gem_exec_balancer (parallel-balancer)
[406.562051] Starting subtest: parallel-balancer
[407.487695] Subtest parallel-balancer: SUCCESS (0.926s)
[407.613551] [126/156] (614s left) vgem_basic (dmabuf-fence-before)
[407.652629] Starting subtest: dmabuf-fence-before
[407.654868] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[407.722032] [127/156] (614s left) kms_force_connector_basic (prune-stale-modes)
[407.802142] Starting subtest: prune-stale-modes
[408.244989] Subtest prune-stale-modes: SUCCESS (0.445s)
[408.387448] [128/156] (614s left) kms_chamelium_audio (hdmi-audio-edid)
[408.792359] Subtest hdmi-audio-edid: SKIP (0.000s)
[409.652933] [129/156] (612s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[409.726113] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[409.730249] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[409.920549] [130/156] (612s left) gem_exec_fence (submit)
[410.092786] Starting subtest: submit
[410.097411] Subtest submit: SKIP (0.000s)
[412.379891] [131/156] (610s left) kms_flip (flip-vs-rmfb)
[412.482308] Starting subtest: flip-vs-rmfb
[412.484607] Starting dynamic subtest: A-eDP1
[421.233404] Dynamic subtest A-eDP1: SUCCESS (8.750s)
[421.244733] Starting dynamic subtest: B-eDP1
[429.929039] Dynamic subtest B-eDP1: SUCCESS (8.695s)
[429.941150] Starting dynamic subtest: C-eDP1
[438.608425] Dynamic subtest C-eDP1: SUCCESS (8.678s)
[438.618821] Starting dynamic subtest: D-eDP1
[447.312104] Dynamic subtest D-eDP1: SUCCESS (8.702s)
[447.317092] Subtest flip-vs-rmfb: SUCCESS (34.834s)
[448.469834] [132/156] (574s left) perf (global-sseu-config-invalid)
[448.590063] Starting subtest: global-sseu-config-invalid
[448.594666] Subtest global-sseu-config-invalid: SKIP (0.000s)
[448.638309] [133/156] (574s left) kms_async_flips (crc-atomic)
[448.739750] Starting subtest: crc-atomic
[449.116041] Starting dynamic subtest: pipe-A-eDP-1
[452.070955] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.932s)
[452.442071] Starting dynamic subtest: pipe-B-eDP-1
[455.366875] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.918s)
[455.727074] Starting dynamic subtest: pipe-C-eDP-1
[458.659565] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.910s)
[459.005820] Starting dynamic subtest: pipe-D-eDP-1
[461.962804] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.938s)
[461.965036] Subtest crc-atomic: SUCCESS (13.193s)
[463.163688] [134/156] (559s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[463.266070] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[466.804418] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.544s)
[467.973160] [135/156] (554s left) kms_dsc (dsc-with-formats)
[468.063381] Starting subtest: dsc-with-formats
[468.103634] Subtest dsc-with-formats: SKIP (0.001s)
[468.149479] [136/156] (554s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[468.254428] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[468.258762] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[468.360483] [137/156] (554s left) gem_mmap_gtt (fault-concurrent-x)
[468.425810] Subtest fault-concurrent-X: SKIP (0.000s)
[468.480388] [138/156] (554s left) gem_workarounds (reset-context)
[468.550342] Starting subtest: reset-context
[468.729911] Subtest reset-context: SUCCESS (0.182s)
[468.836818] [139/156] (554s left) kms_flip (basic-plain-flip)
[468.931477] Starting subtest: basic-plain-flip
[468.933498] Starting dynamic subtest: A-eDP1
[470.628841] Dynamic subtest A-eDP1: SUCCESS (1.696s)
[470.642707] Starting dynamic subtest: B-eDP1
[472.328111] Dynamic subtest B-eDP1: SUCCESS (1.698s)
[472.341053] Starting dynamic subtest: C-eDP1
[474.035046] Dynamic subtest C-eDP1: SUCCESS (1.705s)
[474.048331] Starting dynamic subtest: D-eDP1
[475.719436] Dynamic subtest D-eDP1: SUCCESS (1.683s)
[475.721836] Subtest basic-plain-flip: SUCCESS (6.792s)
[477.027505] [140/156] (546s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[477.135413] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[477.139691] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[477.269080] [141/156] (545s left) kms_setmode (basic-clone-single-crtc)
[477.315923] Starting subtest: basic-clone-single-crtc
[477.322515] Subtest basic-clone-single-crtc: SKIP (0.000s)
[477.414628] [142/156] (545s left) kms_frontbuffer_tracking (fbc-suspend)
[477.513790] Starting subtest: fbc-suspend
[515.431757] Subtest fbc-suspend: SUCCESS (7.825s)
[516.588972] [143/156] (506s left) kms_pm_rpm (pm-caching)
[518.535540] Starting subtest: pm-caching
[518.540569] Subtest pm-caching: SKIP (0.000s)
[518.937942] [144/156] (504s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[519.027721] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[519.031745] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[519.125057] [145/156] (504s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[519.225027] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[519.229334] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[519.322950] [146/156] (504s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[519.411048] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[519.413232] Starting dynamic subtest: pipe-A-eDP-1
[519.436925] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[519.449224] Starting dynamic subtest: pipe-B-eDP-1
[519.471056] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[519.481649] Starting dynamic subtest: pipe-C-eDP-1
[519.502457] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[519.513284] Starting dynamic subtest: pipe-D-eDP-1
[519.534152] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[519.538185] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[521.659436] [147/156] (501s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[521.758274] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[521.762372] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[521.845511] [148/156] (501s left) gem_exec_big (single)
[521.899964] Starting subtest: single
[526.546747] Subtest single: SUCCESS (4.641s)
[526.812640] [149/156] (496s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[526.913932] Starting subtest: yf-tiled-ccs-to-y-tiled
[526.918388] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[527.106013] [150/156] (496s left) gem_create (create-massive)
[527.158254] Starting subtest: create-massive
[527.160277] Subtest create-massive: SUCCESS (0.000s)
[527.365304] [151/156] (496s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[527.477424] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[531.538655] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.063s)
[532.686787] [152/156] (491s left) vgem_basic (bad-handle)
[532.735506] Starting subtest: bad-handle
[532.737734] Subtest bad-handle: SUCCESS (0.000s)
[532.796604] [153/156] (490s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[532.895639] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[532.899774] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[532.993681] [154/156] (490s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[533.092299] Starting subtest: 4-tiled-32bpp-rotate-180
[534.583510] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.491s)
[534.730003] [155/156] (489s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[534.835707] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[534.839150] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[534.931404] [156/156] (488s left) dmabuf_sync_file (import-multiple-read-write)
[534.970023] Starting subtest: import-multiple-read-write
[534.978845] Subtest import-multiple-read-write: SUCCESS (0.010s)
[535.039271] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_pxp
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: i915_pm_rps
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_ctx_shared
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: api_intel_allocator
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: kms_atomic_interruptible
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_softpin
results: parsing output: 18/ for test: kms_busy
results: parsing output: 19/ for test: kms_hdr
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_huc_copy
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: i915_drm_fdinfo
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_pm_dc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: gem_busy
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: syncobj_basic
results: parsing output: 44/ for test: gem_userptr_blits
results: parsing output: 45/ for test: kms_lease
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: gem_flink_basic
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_dirtyfb
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_spin_batch
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: gem_ctx_param
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_vm_create
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: kms_sequence
results: parsing output: 69/ for test: kms_scaling_modes
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_mmap_gtt
results: parsing output: 75/ for test: kms_chamelium_edid
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: testdisplay
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_set_tiling_vs_blt
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_color
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_lease
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_pread
results: parsing output: 104/ for test: syncobj_basic
results: parsing output: 105/ for test: i915_drm_fdinfo
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: i915_query
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: prime_vgem
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: gem_ctx_bad_destroy
results: parsing output: 114/ for test: kms_vrr
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_chamelium_hpd
results: parsing output: 118/ for test: gem_exec_await
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: gen9_exec_parse
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: vgem_basic
results: parsing output: 126/ for test: kms_force_connector_basic
results: parsing output: 127/ for test: kms_chamelium_audio
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: perf
results: parsing output: 132/ for test: kms_async_flips
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_dsc
results: parsing output: 135/ for test: kms_big_fb
results: parsing output: 136/ for test: gem_mmap_gtt
results: parsing output: 137/ for test: gem_workarounds
results: parsing output: 138/ for test: kms_flip
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_setmode
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_pm_rpm
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_big_fb
results: parsing output: 145/ for test: kms_ccs
results: parsing output: 146/ for test: kms_flip_scaled_crc
results: parsing output: 147/ for test: gem_exec_big
results: parsing output: 148/ for test: gem_render_copy
results: parsing output: 149/ for test: gem_create
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: vgem_basic
results: parsing output: 152/ for test: kms_psr2_sf
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: dmabuf_sync_file
Done.