[59.865832] Initializing watchdogs
[59.865966]   /dev/watchdog0
[59.881692] [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]
[59.885857] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.888166] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.891874] [001/132] (960s left) gem_exec_schedule (submit-early-slice)
[59.996105] Starting subtest: submit-early-slice
[59.998312] Starting dynamic subtest: rcs0
[60.061631] Dynamic subtest rcs0: SUCCESS (0.068s)
[60.070735] Starting dynamic subtest: bcs0
[60.117932] Dynamic subtest bcs0: SUCCESS (0.057s)
[60.125199] Starting dynamic subtest: vcs0
[60.176651] Dynamic subtest vcs0: SUCCESS (0.059s)
[60.183591] Starting dynamic subtest: vcs1
[60.233547] Dynamic subtest vcs1: SUCCESS (0.057s)
[60.241488] Starting dynamic subtest: vecs0
[60.284724] Dynamic subtest vecs0: SUCCESS (0.051s)
[60.293923] Starting dynamic subtest: ccs0
[60.336835] Dynamic subtest ccs0: SUCCESS (0.052s)
[60.339224] Subtest submit-early-slice: SUCCESS (0.346s)
[61.993674] [002/132] (958s left) kms_vblank (query-forked-busy-hang)
[62.095870] Starting subtest: query-forked-busy-hang
[62.098214] Starting dynamic subtest: pipe-A-eDP-1
[89.414399] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.351s)
[89.427123] Starting dynamic subtest: pipe-D-eDP-1
[103.638371] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.218s)
[103.640682] Subtest query-forked-busy-hang: SUCCESS (41.576s)
[104.503674] [003/132] (915s left) kms_dsc (dsc-fractional-bpp)
[104.592331] Starting subtest: dsc-fractional-bpp
[104.606050] Subtest dsc-fractional-bpp: SKIP (0.000s)
[104.659708] [004/132] (915s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[104.753714] Starting subtest: yf-tiled-16bpp-rotate-90
[104.757854] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[104.850100] [005/132] (915s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[104.941912] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[104.946156] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[105.047356] [006/132] (915s left) prime_udl
[105.122382] [007/132] (915s left) gem_softpin (zero)
[105.177693] Starting subtest: zero
[105.186708] Subtest zero: SUCCESS (0.008s)
[105.305214] [008/132] (915s left) gem_ringfill (legacy-basic)
[110.936328] Starting subtest: legacy-basic
[110.938980] Starting dynamic subtest: default
[110.993190] Dynamic subtest default: SUCCESS (0.058s)
[111.003258] Starting dynamic subtest: render
[111.037043] Dynamic subtest render: SUCCESS (0.042s)
[111.047072] Starting dynamic subtest: bsd
[111.080035] Dynamic subtest bsd: SUCCESS (0.041s)
[111.090510] Starting dynamic subtest: bsd1
[111.123054] Dynamic subtest bsd1: SUCCESS (0.041s)
[111.131977] Starting dynamic subtest: bsd2
[111.163076] Dynamic subtest bsd2: SUCCESS (0.039s)
[111.171692] Starting dynamic subtest: blt
[111.208280] Dynamic subtest blt: SUCCESS (0.044s)
[111.217258] Starting dynamic subtest: vebox
[111.251227] Dynamic subtest vebox: SUCCESS (0.042s)
[111.253870] Subtest legacy-basic: SUCCESS (0.318s)
[111.320308] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[111.323532] [009/132] (909s left) kms_big_fb (linear-64bpp-rotate-90)
[111.427172] Starting subtest: linear-64bpp-rotate-90
[111.446380] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[111.546187] [010/132] (909s left) kms_properties (colorop-properties-legacy)
[111.646579] Starting subtest: colorop-properties-legacy
[111.649090] Starting dynamic subtest: pipe-A-eDP-1
[112.050493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.403s)
[112.059954] Starting dynamic subtest: pipe-B-eDP-1
[113.092685] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.040s)
[113.100820] Starting dynamic subtest: pipe-C-eDP-1
[114.121281] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.028s)
[114.129228] Starting dynamic subtest: pipe-D-eDP-1
[115.146370] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.025s)
[115.148704] Subtest colorop-properties-legacy: SUCCESS (3.499s)
[115.954247] [011/132] (904s left) prime_busy (after)
[116.025601] Starting subtest: after
[116.028086] Starting dynamic subtest: rcs0
[116.054508] Dynamic subtest rcs0: SUCCESS (0.027s)
[116.063828] Starting dynamic subtest: bcs0
[116.097473] Dynamic subtest bcs0: SUCCESS (0.042s)
[116.105460] Starting dynamic subtest: vcs0
[116.137751] Dynamic subtest vcs0: SUCCESS (0.040s)
[116.146299] Starting dynamic subtest: vcs1
[116.181181] Dynamic subtest vcs1: SUCCESS (0.043s)
[116.189440] Starting dynamic subtest: vecs0
[116.223943] Dynamic subtest vecs0: SUCCESS (0.042s)
[116.234459] Starting dynamic subtest: ccs0
[116.265545] Dynamic subtest ccs0: SUCCESS (0.041s)
[116.374424] Subtest after: SUCCESS (0.347s)
[116.461411] [012/132] (904s left) syncobj_timeline (wait-zero-handles)
[116.522165] Starting subtest: wait-zero-handles
[116.524539] Subtest wait-zero-handles: SUCCESS (0.000s)
[116.619801] [013/132] (904s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[116.724362] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[116.728903] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[116.823997] [014/132] (904s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[116.928989] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[116.931224] Starting dynamic subtest: pipe-A-eDP-1
[117.013460] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[117.020553] Starting dynamic subtest: pipe-B-eDP-1
[118.129067] Dynamic subtest pipe-B-eDP-1: SKIP (1.114s)
[118.133842] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.204s)
[119.310759] [015/132] (901s left) gem_lmem_swapping (heavy-verify-random-ccs)
[119.356651] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[119.399054] [016/132] (901s left) gem_ctx_param (invalid-ctx-get)
[119.447719] Starting subtest: invalid-ctx-get
[119.450274] Subtest invalid-ctx-get: SUCCESS (0.000s)
[119.517735] [017/132] (901s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[119.614784] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[119.619181] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[120.766496] [018/132] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[120.860148] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[120.864192] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[120.963563] [019/132] (900s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[121.070663] Starting subtest: fbcpsr-rgb565-draw-render
[128.082062] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.014s)
[128.212332] [020/132] (892s left) gem_ctx_param (invalid-get-engines)
[128.280641] Starting subtest: invalid-get-engines
[128.283421] Subtest invalid-get-engines: SUCCESS (0.001s)
[128.396075] [021/132] (892s left) gen9_exec_parse (shadow-peek)
[128.450147] Subtest shadow-peek: SKIP (0.000s)
[128.515056] [022/132] (892s left) gem_readwrite (beyond-eob)
[128.576434] Subtest beyond-EOB: SKIP (0.000s)
[128.636031] [023/132] (892s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[128.699379] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[128.801787] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.102s)
[128.887439] [024/132] (892s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[128.987523] Starting subtest: y-tiled-32bpp-rotate-0
[128.991695] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[129.071447] [025/132] (892s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[129.167718] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[129.169944] Starting dynamic subtest: pipe-A-eDP-1
[129.189374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[129.197583] Starting dynamic subtest: pipe-B-eDP-1
[129.216715] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[129.223971] Starting dynamic subtest: pipe-C-eDP-1
[129.243203] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[129.250248] Starting dynamic subtest: pipe-D-eDP-1
[129.269978] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[129.272223] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[131.453269] [026/132] (889s left) kms_psr (psr2-sprite-blt)
[131.555990] Starting subtest: psr2-sprite-blt
[131.558364] Starting dynamic subtest: eDP-1
[133.254329] Dynamic subtest eDP-1: SUCCESS (1.698s)
[133.256617] Subtest psr2-sprite-blt: SUCCESS (1.698s)
[134.119097] [027/132] (887s left) gem_exec_reloc (basic-concurrent0)
[134.177105] Subtest basic-concurrent0: SKIP (0.000s)
[134.239736] [028/132] (887s left) gem_eio (hibernate)
[134.451346] Starting subtest: hibernate
[148.992995] Subtest hibernate: SUCCESS (14.539s)
[156.145940] [029/132] (872s left) kms_scaling_modes (scaling-mode-center)
[156.268937] Starting subtest: scaling-mode-center
[156.271334] Starting dynamic subtest: pipe-A-eDP-1
[156.362355] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[156.370917] Starting dynamic subtest: pipe-B-eDP-1
[157.508297] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.137s)
[157.520142] Starting dynamic subtest: pipe-C-eDP-1
[158.624425] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[158.635546] Starting dynamic subtest: pipe-D-eDP-1
[159.765824] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[159.768250] Subtest scaling-mode-center: SUCCESS (3.500s)
[160.929188] [030/132] (867s left) perf (short-reads)
[161.063586] Starting subtest: short-reads
[161.076916] Subtest short-reads: SUCCESS (0.014s)
[161.127117] [031/132] (867s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[161.227725] Starting subtest: addfb25-y-tiled-small-legacy
[161.231980] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[161.322219] [032/132] (867s left) gem_exec_reloc (basic-write-read-noreloc)
[161.390753] Subtest basic-write-read-noreloc: SKIP (0.000s)
[161.466494] [033/132] (867s left) gem_mmap_offset (oob-read)
[161.522053] Starting subtest: oob-read
[161.524381] Subtest oob-read: SUCCESS (0.000s)
[161.638761] [034/132] (867s left) gem_exec_balancer (bonded-false-hang)
[161.902554] Starting subtest: bonded-false-hang
[161.907851] Subtest bonded-false-hang: SKIP (0.000s)
[162.004009] [035/132] (866s left) core_getclient (basic)
[162.064158] Starting subtest: basic
[162.066537] Subtest basic: SUCCESS (0.000s)
[162.168799] [036/132] (866s left) kms_cursor_crc (cursor-sliding-64x64)
[162.355098] Starting subtest: cursor-sliding-64x64
[162.359999] Starting dynamic subtest: pipe-A-eDP-1
[165.583799] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.225s)
[165.611278] Starting dynamic subtest: pipe-D-eDP-1
[169.542578] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.938s)
[169.545084] Subtest cursor-sliding-64x64: SUCCESS (7.187s)
[170.394184] [037/132] (858s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[170.495116] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[174.198035] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.706s)
[175.400266] [038/132] (853s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[175.508903] Starting subtest: basic-max-pipe-crc-check
[175.513652] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[175.557874] [039/132] (853s left) kms_chamelium_edid (hdmi-mode-timings)
[175.937496] Subtest hdmi-mode-timings: SKIP (0.000s)
[176.703044] [040/132] (852s left) kms_pm_rpm (fences)
[178.240691] Starting subtest: fences
[178.245624] Subtest fences: SKIP (0.000s)
[178.983910] [041/132] (849s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[179.081579] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[179.106974] Starting dynamic subtest: pipe-A-plane-0
[179.395954] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[179.408125] Starting dynamic subtest: pipe-A-plane-3
[179.640448] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[179.649291] Starting dynamic subtest: pipe-A-plane-5
[179.653597] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[180.747838] Starting dynamic subtest: pipe-B-plane-0
[181.050947] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[181.059471] Starting dynamic subtest: pipe-B-plane-3
[181.285420] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[181.294990] Starting dynamic subtest: pipe-B-plane-5
[181.300069] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[181.593233] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.511s)
[182.425126] [042/132] (846s left) dmabuf_sync_file (export-basic)
[182.477166] Starting subtest: export-basic
[182.479124] Subtest export-basic: SUCCESS (0.001s)
[182.536042] [043/132] (846s left) gem_softpin (softpin)
[182.587921] Starting subtest: softpin
[214.818724] Subtest softpin: SUCCESS (32.225s)
[214.938487] [044/132] (814s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[215.048843] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[215.051049] Starting dynamic subtest: pipe-A-eDP-1
[215.073215] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[215.085204] Starting dynamic subtest: pipe-B-eDP-1
[215.106249] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[215.115077] Starting dynamic subtest: pipe-C-eDP-1
[215.136606] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[215.145106] Starting dynamic subtest: pipe-D-eDP-1
[215.168579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[215.172683] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[217.190181] [045/132] (811s left) api_intel_allocator (simple-allocator)
[217.253349] Starting subtest: simple-allocator
[217.255869] Starting dynamic subtest: basic
[217.258260] Dynamic subtest basic: SUCCESS (0.003s)
[217.268992] Starting dynamic subtest: parallel-one
[217.427709] Dynamic subtest parallel-one: SUCCESS (0.173s)
[217.436235] Starting dynamic subtest: print
[217.438393] Dynamic subtest print: SUCCESS (0.000s)
[217.446723] Starting dynamic subtest: reuse
[217.448623] Dynamic subtest reuse: SUCCESS (0.000s)
[217.456589] Starting dynamic subtest: reserve
[217.458518] Dynamic subtest reserve: SUCCESS (0.000s)
[217.466328] Starting dynamic subtest: fork-reopen-allocator
[217.468231] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[217.470080] Subtest simple-allocator: SUCCESS (0.190s)
[217.572332] [046/132] (811s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[217.633092] Subtest writes-after-reads: SKIP (0.000s)
[217.699485] [047/132] (811s left) kms_color (ctm-0-50)
[217.781975] Starting subtest: ctm-0-50
[217.784119] Starting dynamic subtest: pipe-A-eDP-1
[221.310487] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.528s)
[221.319685] Starting dynamic subtest: pipe-B-eDP-1
[225.433696] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.123s)
[225.442380] Starting dynamic subtest: pipe-C-eDP-1
[229.493299] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.059s)
[229.502717] Starting dynamic subtest: pipe-D-eDP-1
[233.452204] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.956s)
[233.454487] Subtest ctm-0-50: SUCCESS (15.669s)
[234.274923] [048/132] (794s left) i915_pm_rps (min-max-config-idle)
[234.337728] Starting subtest: min-max-config-idle
[234.342614] Subtest min-max-config-idle: SKIP (0.001s)
[234.437303] [049/132] (794s left) kms_flip (modeset-vs-vblank-race-interruptible)
[234.538260] Starting subtest: modeset-vs-vblank-race-interruptible
[234.540515] Starting dynamic subtest: A-eDP1
[239.177977] Dynamic subtest A-eDP1: SUCCESS (4.637s)
[239.193577] Starting dynamic subtest: B-eDP1
[243.841633] Dynamic subtest B-eDP1: SUCCESS (4.660s)
[243.857227] Starting dynamic subtest: C-eDP1
[248.442140] Dynamic subtest C-eDP1: SUCCESS (4.597s)
[248.452262] Starting dynamic subtest: D-eDP1
[252.919999] Dynamic subtest D-eDP1: SUCCESS (4.477s)
[252.925364] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.387s)
[254.083839] [050/132] (775s left) kms_flip (wf_vblank-ts-check-interruptible)
[254.190481] Starting subtest: wf_vblank-ts-check-interruptible
[254.195398] Starting dynamic subtest: A-eDP1
[263.129737] Dynamic subtest A-eDP1: SUCCESS (8.935s)
[263.140928] Starting dynamic subtest: B-eDP1
[272.056754] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[272.066138] Starting dynamic subtest: C-eDP1
[280.977129] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[280.988066] Starting dynamic subtest: D-eDP1
[289.902242] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[289.907220] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.715s)
[291.119052] [051/132] (738s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[291.233577] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[291.238271] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[291.345962] [052/132] (738s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[291.449851] Starting subtest: psr-modesetfrombusy
[297.588814] Subtest psr-modesetfrombusy: SUCCESS (6.142s)
[297.730131] [053/132] (731s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[297.822947] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[297.824890] Starting dynamic subtest: pipe-A-eDP-1
[297.843965] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[297.856839] Starting dynamic subtest: pipe-B-eDP-1
[297.874595] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[297.885267] Starting dynamic subtest: pipe-C-eDP-1
[297.902495] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[297.910112] Starting dynamic subtest: pipe-D-eDP-1
[297.928172] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[297.931766] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[300.148495] [054/132] (729s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[300.220143] Starting subtest: map-fixed-invalidate-overlap
[300.224662] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[300.347366] [055/132] (729s left) fbdev (info)
[300.388312] Starting subtest: info
[300.390505] Subtest info: SUCCESS (0.000s)
[300.464504] [056/132] (729s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[300.839512] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[301.646196] [057/132] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[301.743792] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[310.299158] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.558s)
[310.413984] [058/132] (719s left) perf_pmu (interrupts-sync)
[310.460021] Starting subtest: interrupts-sync
[311.553347] Subtest interrupts-sync: SUCCESS (1.093s)
[311.673030] [059/132] (718s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[311.773066] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[316.203544] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.435s)
[317.378313] [060/132] (712s left) gem_ctx_sseu (mmap-args)
[317.443242] Subtest mmap-args: SKIP (0.000s)
[317.517526] [061/132] (712s left) kms_psr (pr-sprite-plane-move)
[317.612034] Starting subtest: pr-sprite-plane-move
[317.616154] Subtest pr-sprite-plane-move: SKIP (0.000s)
[317.682099] [062/132] (712s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[317.780578] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[324.358526] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.579s)
[324.461614] [063/132] (705s left) kms_invalid_mode (zero-vdisplay)
[324.559099] Starting subtest: zero-vdisplay
[324.561193] Starting dynamic subtest: pipe-A-eDP-1
[324.849904] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[324.859337] Starting dynamic subtest: pipe-B-eDP-1
[324.861212] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[324.869735] Starting dynamic subtest: pipe-C-eDP-1
[324.871851] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[324.880600] Starting dynamic subtest: pipe-D-eDP-1
[324.882946] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[324.885292] Subtest zero-vdisplay: SUCCESS (0.298s)
[325.645350] [064/132] (704s left) gem_eio (wait-10ms)
[325.852929] Starting subtest: wait-10ms
[326.185912] Subtest wait-10ms: SUCCESS (0.333s)
[326.326574] [065/132] (703s left) kms_frontbuffer_tracking (psr-1p-rte)
[326.426656] Starting subtest: psr-1p-rte
[331.862432] Subtest psr-1p-rte: SUCCESS (5.440s)
[332.013150] [066/132] (698s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[332.116128] Starting subtest: 4-tiled-16bpp-rotate-0
[333.383771] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.268s)
[333.497579] [067/132] (696s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[333.599066] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[333.610566] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[333.700166] [068/132] (696s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[333.803955] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[333.807336] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[333.910303] [069/132] (696s left) prime_mmap_kms (buffer-sharing)
[334.010511] Starting subtest: buffer-sharing
[334.459080] Subtest buffer-sharing: SUCCESS (0.448s)
[335.334674] [070/132] (694s left) kms_sequence (queue-busy)
[335.430194] Starting subtest: queue-busy
[335.432066] Starting dynamic subtest: pipe-A-eDP-1
[337.351531] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s)
[337.361137] Starting dynamic subtest: pipe-B-eDP-1
[339.928212] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.574s)
[339.938078] Starting dynamic subtest: pipe-C-eDP-1
[342.522321] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.592s)
[342.531508] Starting dynamic subtest: pipe-D-eDP-1
[345.058757] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s)
[345.061071] Subtest queue-busy: SUCCESS (9.629s)
[345.848485] [071/132] (684s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[345.968585] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[345.973289] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[346.064886] [072/132] (684s left) gem_exec_schedule (u-submit-late-slice)
[346.133377] Starting subtest: u-submit-late-slice
[346.135288] Starting dynamic subtest: rcs0
[346.175710] Dynamic subtest rcs0: SUCCESS (0.045s)
[346.186464] Starting dynamic subtest: bcs0
[346.209974] Dynamic subtest bcs0: SUCCESS (0.034s)
[346.219573] Starting dynamic subtest: vcs0
[346.245051] Dynamic subtest vcs0: SUCCESS (0.034s)
[346.253713] Starting dynamic subtest: vcs1
[346.275654] Dynamic subtest vcs1: SUCCESS (0.030s)
[346.284939] Starting dynamic subtest: vecs0
[346.306436] Dynamic subtest vecs0: SUCCESS (0.030s)
[346.316116] Starting dynamic subtest: ccs0
[346.348188] Dynamic subtest ccs0: SUCCESS (0.041s)
[346.350577] Subtest u-submit-late-slice: SUCCESS (0.218s)
[347.955548] [073/132] (682s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[348.068927] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[348.072996] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[348.163292] [074/132] (682s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[348.226470] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[348.329214] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[348.416641] [075/132] (681s left) gem_render_linear_blits (basic)
[348.472614] Starting subtest: basic
[348.493675] Subtest basic: SUCCESS (0.022s)
[348.579534] [076/132] (681s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[348.681914] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[348.684204] Starting dynamic subtest: pipe-A
[349.018549] Dynamic subtest pipe-A: SUCCESS (0.337s)
[349.028120] Starting dynamic subtest: pipe-B
[350.440071] Dynamic subtest pipe-B: SUCCESS (1.420s)
[350.452129] Starting dynamic subtest: pipe-C
[351.869458] Dynamic subtest pipe-C: SUCCESS (1.428s)
[351.885228] Starting dynamic subtest: pipe-D
[353.304238] Dynamic subtest pipe-D: SUCCESS (1.433s)
[353.306410] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.624s)
[354.481146] [077/132] (675s left) syncobj_timeline (single-wait-for-submit-signaled)
[354.532787] Starting subtest: single-wait-for-submit-signaled
[354.535197] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[354.630671] [078/132] (675s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[354.732883] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[354.737171] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[354.823385] [079/132] (675s left) kms_psr (fbc-pr-primary-render)
[354.914910] Starting subtest: fbc-pr-primary-render
[354.919610] Subtest fbc-pr-primary-render: SKIP (0.000s)
[354.985030] [080/132] (675s left) gem_ctx_engines (execute-one)
[355.063683] Starting subtest: execute-one
[357.757580] Subtest execute-one: SUCCESS (2.694s)
[357.961080] [081/132] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[358.074239] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[364.956064] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.883s)
[365.091685] [082/132] (665s left) gem_exec_capture (capture-invisible)
[365.160340] Starting subtest: capture-invisible
[365.162658] Starting dynamic subtest: smem0
[365.167157] Dynamic subtest smem0: SKIP (0.000s)
[365.171489] Subtest capture-invisible: SKIP (0.001s)
[365.258432] [083/132] (665s left) gem_eio (in-flight-immediate)
[365.492057] Starting subtest: in-flight-immediate
[373.808635] Subtest in-flight-immediate: SUCCESS (8.316s)
[373.931398] [084/132] (656s left) kms_cursor_crc (cursor-alpha-opaque)
[374.031989] Starting subtest: cursor-alpha-opaque
[374.034259] Starting dynamic subtest: pipe-A-eDP-1
[374.639786] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[374.650401] Starting dynamic subtest: pipe-D-eDP-1
[375.900705] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.261s)
[375.903126] Subtest cursor-alpha-opaque: SUCCESS (1.870s)
[376.689219] [085/132] (654s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[376.748763] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[376.809234] [086/132] (654s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[376.869318] Starting subtest: y-tiled-ccs-to-x-tiled
[376.873709] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[377.054590] [087/132] (653s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[377.109065] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[377.111254] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[377.206283] [088/132] (653s left) perf (invalid-oa-exponent)
[377.304758] Starting subtest: invalid-oa-exponent
[377.320524] Subtest invalid-oa-exponent: SUCCESS (0.015s)
[377.368581] [089/132] (653s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[377.464167] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[377.466431] Starting dynamic subtest: pipe-A-default-mode
[380.242590] Dynamic subtest pipe-A-default-mode: SUCCESS (2.777s)
[380.244590] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.779s)
[381.070450] [090/132] (649s left) i915_selftest (mock)
[382.954701] Starting subtest: mock
[382.957340] Starting dynamic subtest: sanitycheck
[383.632360] Dynamic subtest sanitycheck: SUCCESS (0.678s)
[383.642359] Starting dynamic subtest: shmem
[384.310438] Dynamic subtest shmem: SUCCESS (0.676s)
[384.320105] Starting dynamic subtest: fence
[392.024066] Dynamic subtest fence: SUCCESS (7.710s)
[392.033871] Starting dynamic subtest: scatterlist
[393.687283] Dynamic subtest scatterlist: SUCCESS (1.662s)
[393.697301] Starting dynamic subtest: syncmap
[397.042358] Dynamic subtest syncmap: SUCCESS (3.353s)
[397.052686] Starting dynamic subtest: uncore
[397.729305] Dynamic subtest uncore: SUCCESS (0.685s)
[397.739363] Starting dynamic subtest: ring
[398.390368] Dynamic subtest ring: SUCCESS (0.659s)
[398.400166] Starting dynamic subtest: engine
[399.059276] Dynamic subtest engine: SUCCESS (0.667s)
[399.069068] Starting dynamic subtest: timelines
[402.800597] Dynamic subtest timelines: SUCCESS (3.739s)
[402.811208] Starting dynamic subtest: requests
[406.748734] Dynamic subtest requests: SUCCESS (3.947s)
[406.763585] Starting dynamic subtest: objects
[407.497119] Dynamic subtest objects: SUCCESS (0.747s)
[407.506749] Starting dynamic subtest: phys
[408.244067] Dynamic subtest phys: SUCCESS (0.745s)
[408.254287] Starting dynamic subtest: dmabuf
[408.993333] Dynamic subtest dmabuf: SUCCESS (0.748s)
[409.002369] Starting dynamic subtest: vma
[414.610018] Dynamic subtest vma: SUCCESS (5.614s)
[414.620306] Starting dynamic subtest: evict
[415.975863] Dynamic subtest evict: SUCCESS (1.362s)
[415.985752] Starting dynamic subtest: gtt
[419.224839] Dynamic subtest gtt: SUCCESS (3.247s)
[419.235305] Starting dynamic subtest: hugepages
[420.110671] Dynamic subtest hugepages: SUCCESS (0.885s)
[420.120706] Starting dynamic subtest: memory_region
[422.462481] Dynamic subtest memory_region: SUCCESS (2.350s)
[422.465247] Subtest mock: SUCCESS (39.507s)
[422.493397] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[422.494111] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[422.497284] [091/132] (608s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[423.993949] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[430.916542] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.925s)
[431.095009] [FACT kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[431.096353] [FACT kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[431.100531] [092/132] (599s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[431.201374] Starting subtest: fbc-psr-sprite-mmap-gtt
[431.203728] Starting dynamic subtest: eDP-1
[431.208267] Dynamic subtest eDP-1: SKIP (0.000s)
[431.212741] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[431.270543] [093/132] (599s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[431.412220] Starting subtest: dp-mst-type-1-suspend-resume
[431.416742] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[431.546493] [094/132] (599s left) kms_big_fb (x-tiled-addfb)
[431.639423] Starting subtest: x-tiled-addfb
[431.641653] Subtest x-tiled-addfb: SUCCESS (0.000s)
[431.736186] [095/132] (599s left) kms_big_fb (4-tiled-addfb-size-overflow)
[431.841313] Starting subtest: 4-tiled-addfb-size-overflow
[431.843668] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[431.942804] [096/132] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[432.026381] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[432.029823] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[432.116318] [097/132] (599s left) kms_lease (cursor-implicit-plane)
[432.223690] Starting subtest: cursor-implicit-plane
[432.225737] Starting dynamic subtest: pipe-A-eDP-1
[432.694987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.469s)
[432.705120] Starting dynamic subtest: pipe-B-eDP-1
[433.822952] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.125s)
[433.834472] Starting dynamic subtest: pipe-C-eDP-1
[434.946983] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[434.955845] Starting dynamic subtest: pipe-D-eDP-1
[436.069982] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[436.072139] Subtest cursor-implicit-plane: SUCCESS (3.844s)
[436.944732] [098/132] (594s left) kms_fbcon_fbt (fbc-suspend)
[437.006314] Starting subtest: fbc-suspend
[486.275876] Subtest fbc-suspend: SUCCESS (19.330s)
[487.607390] [099/132] (543s left) gem_vm_create (create-ext)
[487.679786] Starting subtest: create-ext
[487.685376] Subtest create-ext: SUCCESS (0.006s)
[487.824026] [100/132] (543s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[487.925471] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[487.931413] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[488.025703] [101/132] (543s left) gem_mmap (bad-object)
[488.094290] Subtest bad-object: SKIP (0.000s)
[488.153055] [102/132] (543s left) gem_reg_read (timestamp-moving)
[488.204734] Starting subtest: timestamp-moving
[489.204424] Subtest timestamp-moving: SUCCESS (1.006s)
[489.283199] [103/132] (542s left) gem_pxp (display-protected-crc)
[489.417787] Starting subtest: display-protected-crc
[491.054071] Subtest display-protected-crc: SUCCESS (1.646s)
[491.159125] [104/132] (540s left) syncobj_timeline (invalid-signal-illegal-point)
[491.220183] Starting subtest: invalid-signal-illegal-point
[491.223010] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[491.319799] [105/132] (540s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[491.418984] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[491.421698] Starting dynamic subtest: pipe-A-default-mode
[494.138233] Dynamic subtest pipe-A-default-mode: SUCCESS (2.726s)
[494.140874] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.728s)
[495.002467] [106/132] (536s left) gem_partial_pwrite_pread (reads)
[495.061152] Subtest reads: SKIP (0.000s)
[495.124708] [107/132] (536s left) perf (gen12-unprivileged-single-ctx-counters)
[495.255910] Starting subtest: gen12-unprivileged-single-ctx-counters
[495.258332] Starting dynamic subtest: rcs0
[495.494485] Dynamic subtest rcs0: SUCCESS (0.240s)
[495.497310] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.241s)
[495.545999] [108/132] (536s left) kms_plane (plane-position-hole)
[495.652267] Starting subtest: plane-position-hole
[496.165455] Starting dynamic subtest: pipe-A-plane-1
[497.472091] Dynamic subtest pipe-A-plane-1: SUCCESS (1.311s)
[497.482125] Starting dynamic subtest: pipe-A-plane-2
[498.711596] Dynamic subtest pipe-A-plane-2: SUCCESS (1.241s)
[498.721581] Starting dynamic subtest: pipe-A-plane-3
[499.970843] Dynamic subtest pipe-A-plane-3: SUCCESS (1.261s)
[499.985113] Starting dynamic subtest: pipe-A-plane-4
[501.285225] Dynamic subtest pipe-A-plane-4: SUCCESS (1.315s)
[501.296192] Starting dynamic subtest: pipe-A-plane-5
[501.315268] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[502.461731] Starting dynamic subtest: pipe-B-plane-1
[503.786135] Dynamic subtest pipe-B-plane-1: SUCCESS (1.334s)
[503.797286] Starting dynamic subtest: pipe-B-plane-2
[505.085170] Dynamic subtest pipe-B-plane-2: SUCCESS (1.300s)
[505.095262] Starting dynamic subtest: pipe-B-plane-3
[506.393173] Dynamic subtest pipe-B-plane-3: SUCCESS (1.307s)
[506.403741] Starting dynamic subtest: pipe-B-plane-4
[507.631225] Dynamic subtest pipe-B-plane-4: SUCCESS (1.238s)
[507.642257] Starting dynamic subtest: pipe-B-plane-5
[507.655573] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[507.658195] Subtest plane-position-hole: SUCCESS (12.021s)
[508.435922] [109/132] (523s left) gem_exec_schedule (implicit-read-write)
[508.514205] Starting subtest: implicit-read-write
[508.516711] Starting dynamic subtest: rcs0
[508.623299] Dynamic subtest rcs0: SUCCESS (0.117s)
[508.635683] Starting dynamic subtest: vcs0
[508.706137] Dynamic subtest vcs0: SUCCESS (0.082s)
[508.718039] Starting dynamic subtest: vcs1
[508.781259] Dynamic subtest vcs1: SUCCESS (0.075s)
[508.792293] Starting dynamic subtest: vecs0
[508.861065] Dynamic subtest vecs0: SUCCESS (0.079s)
[508.871127] Starting dynamic subtest: ccs0
[508.952661] Dynamic subtest ccs0: SUCCESS (0.091s)
[508.955323] Subtest implicit-read-write: SUCCESS (0.447s)
[510.251872] [110/132] (521s left) gem_exec_flush (basic-batch-kernel-default-uc)
[510.310129] Starting subtest: basic-batch-kernel-default-uc
[516.661279] Subtest basic-batch-kernel-default-uc: SUCCESS (6.475s)
[516.862792] [111/132] (515s left) gem_ctx_persistence (heartbeat-stop)
[516.922280] Starting subtest: heartbeat-stop
[516.928184] Subtest heartbeat-stop: SKIP (0.000s)
[517.034604] [112/132] (514s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[517.296056] Starting subtest: cursor-rapid-movement-128x128
[517.301581] Starting dynamic subtest: pipe-A-eDP-1
[517.831858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[517.862952] Starting dynamic subtest: pipe-D-eDP-1
[518.992904] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.152s)
[518.994958] Subtest cursor-rapid-movement-128x128: SUCCESS (1.719s)
[519.835753] [113/132] (512s left) kms_cdclk (plane-scaling)
[519.930996] Starting subtest: plane-scaling
[519.933607] Starting dynamic subtest: pipe-A-eDP-1
[520.219832] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[520.230187] Starting dynamic subtest: pipe-B-eDP-1
[520.235276] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[520.244922] Starting dynamic subtest: pipe-C-eDP-1
[520.249938] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[520.259115] Starting dynamic subtest: pipe-D-eDP-1
[520.264832] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[520.270112] Subtest plane-scaling: SKIP (0.295s)
[521.049985] [114/132] (510s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[521.143029] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[521.148005] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[521.213642] [115/132] (510s left) perf_pmu (idle)
[521.255116] Starting subtest: idle
[521.257584] Starting dynamic subtest: rcs0
[521.789907] Dynamic subtest rcs0: SUCCESS (0.542s)
[521.800522] Starting dynamic subtest: bcs0
[522.305606] Dynamic subtest bcs0: SUCCESS (0.517s)
[522.317692] Starting dynamic subtest: vcs0
[522.825701] Dynamic subtest vcs0: SUCCESS (0.521s)
[522.838483] Starting dynamic subtest: vcs1
[523.345565] Dynamic subtest vcs1: SUCCESS (0.521s)
[523.356118] Starting dynamic subtest: vecs0
[523.866926] Dynamic subtest vecs0: SUCCESS (0.522s)
[523.881631] Starting dynamic subtest: ccs0
[524.384263] Dynamic subtest ccs0: SUCCESS (0.518s)
[524.387158] Subtest idle: SUCCESS (3.158s)
[524.488416] [116/132] (507s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[524.586138] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[524.591873] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[524.659535] [117/132] (507s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[524.720972] Starting subtest: invalid-bsd1-flag-on-vebox
[524.723702] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[524.818900] [118/132] (507s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[524.917198] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[524.919609] Starting dynamic subtest: pipe-A-eDP-1
[526.267481] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.358s)
[526.544268] Starting dynamic subtest: pipe-B-eDP-1
[527.579629] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.049s)
[527.847172] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.944s)
[528.688932] [119/132] (503s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[528.779076] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[528.790298] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[528.871587] [120/132] (503s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[528.964503] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[528.969893] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[529.060585] [121/132] (503s left) gen7_exec_parse (basic-rejected)
[529.128877] Subtest basic-rejected: SKIP (0.000s)
[529.211559] [122/132] (503s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[529.309774] Starting subtest: psr2-cursor-plane-update-sf
[529.312333] Starting dynamic subtest: pipe-A-eDP-1
[529.876337] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[529.887317] Starting dynamic subtest: pipe-B-eDP-1
[531.180881] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.307s)
[531.183310] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.886s)
[532.042283] [123/132] (500s left) gem_exec_fence (syncobj-timeline-chain-engines)
[532.585139] Starting subtest: syncobj-timeline-chain-engines
[532.673665] Subtest syncobj-timeline-chain-engines: SUCCESS (0.090s)
[534.259051] [124/132] (498s left) gem_workarounds (reset-fd)
[534.325802] Starting subtest: reset-fd
[534.503043] Subtest reset-fd: SUCCESS (0.176s)
[534.620141] [125/132] (497s left) i915_module_load (resize-bar)
[534.661954] Starting subtest: resize-bar
[534.668603] Subtest resize-bar: SKIP (0.006s)
[534.715861] [126/132] (497s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[534.808358] Starting subtest: crc-primary-suspend-y-tiled-ccs
[534.811000] Starting dynamic subtest: pipe-A-eDP-1
[534.822094] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[534.835231] Starting dynamic subtest: pipe-B-eDP-1
[534.845802] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[534.856125] Starting dynamic subtest: pipe-C-eDP-1
[534.866726] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[534.876529] Starting dynamic subtest: pipe-D-eDP-1
[534.887059] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[534.892196] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[537.012053] [127/132] (495s left) syncobj_timeline (etime-single-wait-submitted)
[537.071542] Starting subtest: etime-single-wait-submitted
[537.179298] Subtest etime-single-wait-submitted: SUCCESS (0.107s)
[537.264681] [128/132] (495s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[537.387308] Starting subtest: short-busy-flip-before-cursor-toggle
[537.392209] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[537.533864] [129/132] (495s left) gem_pxp (reject-modify-context-protection-on)
[537.592036] Starting subtest: reject-modify-context-protection-on
[537.595268] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[537.715706] [130/132] (494s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[537.832992] Starting subtest: cursorB-vs-flipB-legacy
[537.837642] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[537.975953] [131/132] (494s left) kms_flip (busy-flip)
[538.070742] Starting subtest: busy-flip
[538.073522] Starting dynamic subtest: A-eDP1
[539.722915] Dynamic subtest A-eDP1: SUCCESS (1.656s)
[539.744289] Starting dynamic subtest: B-eDP1
[541.448305] Dynamic subtest B-eDP1: SUCCESS (1.724s)
[541.459113] Starting dynamic subtest: C-eDP1
[543.156190] Dynamic subtest C-eDP1: SUCCESS (1.708s)
[543.167338] Starting dynamic subtest: D-eDP1
[544.790218] Dynamic subtest D-eDP1: SUCCESS (1.632s)
[544.796798] Subtest busy-flip: SUCCESS (6.735s)
[545.956974] [132/132] (486s left) perf (whitelisted-registers-userspace-config)
[546.058789] Starting subtest: whitelisted-registers-userspace-config
[546.061437] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[546.106289] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: kms_dsc
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: prime_udl
results: parsing output: 6/ for test: gem_softpin
results: parsing output: 7/ for test: gem_ringfill
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_properties
results: parsing output: 10/ for test: prime_busy
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: gem_lmem_swapping
results: parsing output: 15/ for test: gem_ctx_param
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: gen9_exec_parse
results: parsing output: 21/ for test: gem_readwrite
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: kms_scaling_modes
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_mmap_offset
results: parsing output: 33/ for test: gem_exec_balancer
results: parsing output: 34/ for test: core_getclient
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_multipipe_modeset
results: parsing output: 38/ for test: kms_chamelium_edid
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: dmabuf_sync_file
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 46/ for test: kms_color
results: parsing output: 47/ for test: i915_pm_rps
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gem_userptr_blits
results: parsing output: 54/ for test: fbdev
results: parsing output: 55/ for test: kms_chamelium_hpd
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_ctx_sseu
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_invalid_mode
results: parsing output: 63/ for test: gem_eio
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: prime_mmap_kms
results: parsing output: 69/ for test: kms_sequence
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: gem_render_linear_blits
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_ctx_engines
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_capture
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: kms_flip_scaled_crc
results: parsing output: 89/ for test: i915_selftest
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_content_protection
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_lease
results: parsing output: 97/ for test: kms_fbcon_fbt
results: parsing output: 98/ for test: gem_vm_create
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_mmap
results: parsing output: 101/ for test: gem_reg_read
results: parsing output: 102/ for test: gem_pxp
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: gem_partial_pwrite_pread
results: parsing output: 106/ for test: perf
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: gem_exec_flush
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_cdclk
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_atomic_transition
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gen7_exec_parse
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: gem_workarounds
results: parsing output: 124/ for test: i915_module_load
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: gem_pxp
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: perf
Done.