[61.352477] Initializing watchdogs
[61.352528]   /dev/watchdog0
[61.366927] [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]
[61.371862] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.374288] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.377979] [001/132] (960s left) gem_exec_schedule (submit-early-slice)
[61.482825] Starting subtest: submit-early-slice
[61.485368] Starting dynamic subtest: rcs0
[61.550128] Dynamic subtest rcs0: SUCCESS (0.070s)
[61.559616] Starting dynamic subtest: bcs0
[61.610502] Dynamic subtest bcs0: SUCCESS (0.059s)
[61.620552] Starting dynamic subtest: vcs0
[61.679355] Dynamic subtest vcs0: SUCCESS (0.069s)
[61.687244] Starting dynamic subtest: vcs1
[61.734561] Dynamic subtest vcs1: SUCCESS (0.054s)
[61.744218] Starting dynamic subtest: vecs0
[61.786616] Dynamic subtest vecs0: SUCCESS (0.053s)
[61.794891] Starting dynamic subtest: ccs0
[61.843860] Dynamic subtest ccs0: SUCCESS (0.057s)
[61.846096] Subtest submit-early-slice: SUCCESS (0.364s)
[63.010936] [002/132] (958s left) kms_vblank (query-forked-busy-hang)
[63.105285] Starting subtest: query-forked-busy-hang
[63.107527] Starting dynamic subtest: pipe-A-eDP-1
[89.699207] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.597s)
[89.712111] Starting dynamic subtest: pipe-D-eDP-1
[114.646387] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.946s)
[114.648406] Subtest query-forked-busy-hang: SUCCESS (51.546s)
[115.484856] [003/132] (906s left) kms_dsc (dsc-fractional-bpp)
[115.580085] Starting subtest: dsc-fractional-bpp
[115.593885] Subtest dsc-fractional-bpp: SKIP (0.000s)
[115.650295] [004/132] (906s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[115.756377] Starting subtest: yf-tiled-16bpp-rotate-90
[115.760525] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[115.849652] [005/132] (906s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[115.944504] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[115.948784] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[116.048311] [006/132] (906s left) prime_udl
[116.132588] [007/132] (905s left) gem_softpin (zero)
[116.187395] Starting subtest: zero
[116.191788] Subtest zero: SUCCESS (0.004s)
[116.330862] [008/132] (905s left) gem_ringfill (legacy-basic)
[121.880957] Starting subtest: legacy-basic
[121.883676] Starting dynamic subtest: default
[121.941648] Dynamic subtest default: SUCCESS (0.062s)
[121.951562] Starting dynamic subtest: render
[121.983185] Dynamic subtest render: SUCCESS (0.041s)
[121.993674] Starting dynamic subtest: bsd
[122.028280] Dynamic subtest bsd: SUCCESS (0.043s)
[122.038538] Starting dynamic subtest: bsd1
[122.071131] Dynamic subtest bsd1: SUCCESS (0.041s)
[122.089059] Starting dynamic subtest: bsd2
[122.111632] Dynamic subtest bsd2: SUCCESS (0.039s)
[122.122720] Starting dynamic subtest: blt
[122.157831] Dynamic subtest blt: SUCCESS (0.045s)
[122.167610] Starting dynamic subtest: vebox
[122.201084] Dynamic subtest vebox: SUCCESS (0.042s)
[122.203537] Subtest legacy-basic: SUCCESS (0.323s)
[122.283005] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[122.286221] [009/132] (899s left) kms_big_fb (linear-64bpp-rotate-90)
[122.394434] Starting subtest: linear-64bpp-rotate-90
[122.414738] Subtest linear-64bpp-rotate-90: SKIP (0.020s)
[122.516685] [010/132] (899s left) kms_properties (colorop-properties-legacy)
[122.611052] Starting subtest: colorop-properties-legacy
[122.613347] Starting dynamic subtest: pipe-A-eDP-1
[122.977220] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.366s)
[122.984597] Starting dynamic subtest: pipe-B-eDP-1
[124.052440] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.072s)
[124.066218] Starting dynamic subtest: pipe-C-eDP-1
[125.083740] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.030s)
[125.092925] Starting dynamic subtest: pipe-D-eDP-1
[126.125890] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.043s)
[126.128295] Subtest colorop-properties-legacy: SUCCESS (3.515s)
[126.922807] [011/132] (895s left) prime_busy (after)
[126.990696] Starting subtest: after
[126.995608] Starting dynamic subtest: rcs0
[127.026515] Dynamic subtest rcs0: SUCCESS (0.033s)
[127.036171] Starting dynamic subtest: bcs0
[127.074842] Dynamic subtest bcs0: SUCCESS (0.048s)
[127.083417] Starting dynamic subtest: vcs0
[127.115388] Dynamic subtest vcs0: SUCCESS (0.040s)
[127.123833] Starting dynamic subtest: vcs1
[127.155909] Dynamic subtest vcs1: SUCCESS (0.040s)
[127.164442] Starting dynamic subtest: vecs0
[127.197383] Dynamic subtest vecs0: SUCCESS (0.041s)
[127.205875] Starting dynamic subtest: ccs0
[127.237407] Dynamic subtest ccs0: SUCCESS (0.040s)
[127.346056] Subtest after: SUCCESS (0.354s)
[127.421090] [012/132] (894s left) syncobj_timeline (wait-zero-handles)
[127.495215] Starting subtest: wait-zero-handles
[127.497579] Subtest wait-zero-handles: SUCCESS (0.000s)
[127.616460] [013/132] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[127.728088] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[127.732264] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[127.826220] [014/132] (894s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[127.920762] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[127.923078] Starting dynamic subtest: pipe-A-eDP-1
[128.017566] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[128.026621] Starting dynamic subtest: pipe-B-eDP-1
[129.205806] Dynamic subtest pipe-B-eDP-1: SKIP (1.187s)
[129.210258] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.290s)
[130.407026] [015/132] (892s left) gem_lmem_swapping (heavy-verify-random-ccs)
[130.446700] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[130.493320] [016/132] (891s left) gem_ctx_param (invalid-ctx-get)
[130.548946] Starting subtest: invalid-ctx-get
[130.552073] Subtest invalid-ctx-get: SUCCESS (0.000s)
[130.623436] [017/132] (891s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[130.717728] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[130.722097] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[131.836413] [018/132] (890s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[131.940677] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[131.945014] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[132.043248] [019/132] (890s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[132.136816] Starting subtest: fbcpsr-rgb565-draw-render
[139.156093] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.025s)
[139.278359] [020/132] (883s left) gem_ctx_param (invalid-get-engines)
[139.334813] Starting subtest: invalid-get-engines
[139.337299] Subtest invalid-get-engines: SUCCESS (0.001s)
[139.444839] [021/132] (883s left) gen9_exec_parse (shadow-peek)
[139.520591] Subtest shadow-peek: SKIP (0.000s)
[139.599388] [022/132] (883s left) gem_readwrite (beyond-eob)
[139.647616] Subtest beyond-EOB: SKIP (0.000s)
[139.704961] [023/132] (883s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[139.761458] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[139.866040] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s)
[139.946513] [024/132] (882s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[140.051671] Starting subtest: y-tiled-32bpp-rotate-0
[140.056290] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[140.166274] [025/132] (882s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[140.264651] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[140.266854] Starting dynamic subtest: pipe-A-eDP-1
[140.286674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[140.296167] Starting dynamic subtest: pipe-B-eDP-1
[140.314770] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[140.321609] Starting dynamic subtest: pipe-C-eDP-1
[140.340099] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[140.348852] Starting dynamic subtest: pipe-D-eDP-1
[140.367705] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[140.369574] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[142.540350] [026/132] (880s left) kms_psr (psr2-sprite-blt)
[142.636362] Starting subtest: psr2-sprite-blt
[142.638545] Starting dynamic subtest: eDP-1
[144.334632] Dynamic subtest eDP-1: SUCCESS (1.697s)
[144.336936] Subtest psr2-sprite-blt: SUCCESS (1.698s)
[145.199942] [027/132] (877s left) gem_exec_reloc (basic-concurrent0)
[145.279328] Subtest basic-concurrent0: SKIP (0.000s)
[145.359590] [028/132] (877s left) gem_eio (hibernate)
[145.568604] Starting subtest: hibernate
[160.345682] Subtest hibernate: SUCCESS (14.772s)
[168.554313] [029/132] (862s left) kms_scaling_modes (scaling-mode-center)
[168.666341] Starting subtest: scaling-mode-center
[168.668755] Starting dynamic subtest: pipe-A-eDP-1
[168.759905] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[168.769092] Starting dynamic subtest: pipe-B-eDP-1
[169.948702] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.188s)
[169.958508] Starting dynamic subtest: pipe-C-eDP-1
[171.058373] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[171.068487] Starting dynamic subtest: pipe-D-eDP-1
[172.179607] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[172.181969] Subtest scaling-mode-center: SUCCESS (3.516s)
[173.338065] [030/132] (857s left) perf (short-reads)
[173.473700] Starting subtest: short-reads
[173.485075] Subtest short-reads: SUCCESS (0.013s)
[173.537129] [031/132] (857s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[173.640204] Starting subtest: addfb25-y-tiled-small-legacy
[173.644602] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[173.733652] [032/132] (857s left) gem_exec_reloc (basic-write-read-noreloc)
[173.808622] Subtest basic-write-read-noreloc: SKIP (0.000s)
[173.879274] [033/132] (857s left) gem_mmap_offset (oob-read)
[173.945834] Starting subtest: oob-read
[173.948201] Subtest oob-read: SUCCESS (0.001s)
[174.051426] [034/132] (857s left) gem_exec_balancer (bonded-false-hang)
[174.311837] Starting subtest: bonded-false-hang
[174.317158] Subtest bonded-false-hang: SKIP (0.000s)
[174.414052] [035/132] (856s left) core_getclient (basic)
[174.471052] Starting subtest: basic
[174.473380] Subtest basic: SUCCESS (0.000s)
[174.569365] [036/132] (856s left) kms_cursor_crc (cursor-sliding-64x64)
[174.761996] Starting subtest: cursor-sliding-64x64
[174.764340] Starting dynamic subtest: pipe-A-eDP-1
[177.998124] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.235s)
[178.030926] Starting dynamic subtest: pipe-D-eDP-1
[181.977496] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.952s)
[181.979786] Subtest cursor-sliding-64x64: SUCCESS (7.215s)
[182.816951] [037/132] (848s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[182.937045] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[186.600358] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.668s)
[187.732093] [038/132] (843s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[187.817326] Starting subtest: basic-max-pipe-crc-check
[187.821803] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[187.867130] [039/132] (843s left) kms_chamelium_edid (hdmi-mode-timings)
[188.268368] Subtest hdmi-mode-timings: SKIP (0.000s)
[189.042747] [040/132] (842s left) kms_pm_rpm (fences)
[191.079415] Starting subtest: fences
[191.083928] Subtest fences: SKIP (0.000s)
[191.462455] [041/132] (840s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[191.563424] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[191.591086] Starting dynamic subtest: pipe-A-plane-0
[191.891682] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[191.906673] Starting dynamic subtest: pipe-A-plane-3
[192.135805] Dynamic subtest pipe-A-plane-3: SUCCESS (0.242s)
[192.145925] Starting dynamic subtest: pipe-A-plane-5
[192.150231] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[193.245887] Starting dynamic subtest: pipe-B-plane-0
[193.537733] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[193.546763] Starting dynamic subtest: pipe-B-plane-3
[193.794777] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[193.804090] Starting dynamic subtest: pipe-B-plane-5
[193.808371] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[194.105154] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.541s)
[194.942825] [042/132] (836s left) dmabuf_sync_file (export-basic)
[195.000609] Starting subtest: export-basic
[195.002786] Subtest export-basic: SUCCESS (0.001s)
[195.057308] [043/132] (836s left) gem_softpin (softpin)
[195.122045] Starting subtest: softpin
[227.491075] Subtest softpin: SUCCESS (32.363s)
[227.599755] [044/132] (804s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[227.701772] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[227.703959] Starting dynamic subtest: pipe-A-eDP-1
[227.725470] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[227.735183] Starting dynamic subtest: pipe-B-eDP-1
[227.755751] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[227.764541] Starting dynamic subtest: pipe-C-eDP-1
[227.785525] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[227.794591] Starting dynamic subtest: pipe-D-eDP-1
[227.815314] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[227.819144] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[229.988612] [045/132] (801s left) api_intel_allocator (simple-allocator)
[230.048310] Starting subtest: simple-allocator
[230.050688] Starting dynamic subtest: basic
[230.052968] Dynamic subtest basic: SUCCESS (0.003s)
[230.066161] Starting dynamic subtest: parallel-one
[230.240062] Dynamic subtest parallel-one: SUCCESS (0.189s)
[230.249252] Starting dynamic subtest: print
[230.251171] Dynamic subtest print: SUCCESS (0.000s)
[230.263169] Starting dynamic subtest: reuse
[230.265280] Dynamic subtest reuse: SUCCESS (0.000s)
[230.274351] Starting dynamic subtest: reserve
[230.276555] Dynamic subtest reserve: SUCCESS (0.000s)
[230.285594] Starting dynamic subtest: fork-reopen-allocator
[230.287885] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[230.290130] Subtest simple-allocator: SUCCESS (0.208s)
[230.396449] [046/132] (801s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[230.462403] Subtest writes-after-reads: SKIP (0.000s)
[230.548417] [047/132] (801s left) kms_color (ctm-0-50)
[230.644446] Starting subtest: ctm-0-50
[230.646418] Starting dynamic subtest: pipe-A-eDP-1
[234.202057] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.558s)
[234.211782] Starting dynamic subtest: pipe-B-eDP-1
[238.425060] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.224s)
[238.435138] Starting dynamic subtest: pipe-C-eDP-1
[242.482188] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.055s)
[242.491067] Starting dynamic subtest: pipe-D-eDP-1
[246.479812] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.995s)
[246.481822] Subtest ctm-0-50: SUCCESS (15.834s)
[247.315604] [048/132] (784s left) i915_pm_rps (min-max-config-idle)
[247.383453] Starting subtest: min-max-config-idle
[247.388126] Subtest min-max-config-idle: SKIP (0.001s)
[247.488589] [049/132] (784s left) kms_flip (modeset-vs-vblank-race-interruptible)
[247.589804] Starting subtest: modeset-vs-vblank-race-interruptible
[247.591633] Starting dynamic subtest: A-eDP1
[252.217121] Dynamic subtest A-eDP1: SUCCESS (4.625s)
[252.228630] Starting dynamic subtest: B-eDP1
[256.846421] Dynamic subtest B-eDP1: SUCCESS (4.626s)
[256.859743] Starting dynamic subtest: C-eDP1
[261.458376] Dynamic subtest C-eDP1: SUCCESS (4.609s)
[261.470704] Starting dynamic subtest: D-eDP1
[266.020496] Dynamic subtest D-eDP1: SUCCESS (4.559s)
[266.025542] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.435s)
[267.180392] [050/132] (764s left) kms_flip (wf_vblank-ts-check-interruptible)
[267.288775] Starting subtest: wf_vblank-ts-check-interruptible
[267.291064] Starting dynamic subtest: A-eDP1
[276.253682] Dynamic subtest A-eDP1: SUCCESS (8.928s)
[276.265613] Starting dynamic subtest: B-eDP1
[285.178318] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[285.189740] Starting dynamic subtest: C-eDP1
[294.105489] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[294.115830] Starting dynamic subtest: D-eDP1
[302.992716] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[302.998634] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.707s)
[304.231115] [051/132] (727s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[304.333350] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[304.337287] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[304.432272] [052/132] (727s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[304.531054] Starting subtest: psr-modesetfrombusy
[310.680927] Subtest psr-modesetfrombusy: SUCCESS (6.154s)
[310.806586] [053/132] (721s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[310.899372] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[310.901332] Starting dynamic subtest: pipe-A-eDP-1
[310.919807] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[310.929254] Starting dynamic subtest: pipe-B-eDP-1
[310.947051] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[310.955500] Starting dynamic subtest: pipe-C-eDP-1
[310.972697] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[310.982053] Starting dynamic subtest: pipe-D-eDP-1
[310.999724] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[311.003158] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[313.158022] [054/132] (718s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[313.228844] Starting subtest: map-fixed-invalidate-overlap
[313.233288] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[313.347550] [055/132] (718s left) fbdev (info)
[313.384171] Starting subtest: info
[313.386396] Subtest info: SUCCESS (0.000s)
[313.459984] [056/132] (718s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[313.844180] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[314.654025] [057/132] (717s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[314.762275] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[323.402768] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.644s)
[323.517639] [058/132] (708s left) perf_pmu (interrupts-sync)
[323.566316] Starting subtest: interrupts-sync
[324.662204] Subtest interrupts-sync: SUCCESS (1.097s)
[324.774040] [059/132] (707s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[324.866316] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[329.350222] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.487s)
[330.552182] [060/132] (701s left) gem_ctx_sseu (mmap-args)
[330.621306] Subtest mmap-args: SKIP (0.000s)
[330.687618] [061/132] (701s left) kms_psr (pr-sprite-plane-move)
[330.781818] Starting subtest: pr-sprite-plane-move
[330.786207] Subtest pr-sprite-plane-move: SKIP (0.000s)
[330.860904] [062/132] (701s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[330.945574] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[337.541164] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.596s)
[337.653374] [063/132] (694s left) kms_invalid_mode (zero-vdisplay)
[337.748718] Starting subtest: zero-vdisplay
[337.751745] Starting dynamic subtest: pipe-A-eDP-1
[338.038864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[338.049062] Starting dynamic subtest: pipe-B-eDP-1
[338.051236] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[338.060748] Starting dynamic subtest: pipe-C-eDP-1
[338.063060] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[338.072318] Starting dynamic subtest: pipe-D-eDP-1
[338.074625] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[338.077100] Subtest zero-vdisplay: SUCCESS (0.300s)
[338.915069] [064/132] (693s left) gem_eio (wait-10ms)
[339.136158] Starting subtest: wait-10ms
[339.496980] Subtest wait-10ms: SUCCESS (0.360s)
[339.641900] [065/132] (692s left) kms_frontbuffer_tracking (psr-1p-rte)
[339.735174] Starting subtest: psr-1p-rte
[345.135752] Subtest psr-1p-rte: SUCCESS (5.405s)
[345.279247] [066/132] (687s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[345.387374] Starting subtest: 4-tiled-16bpp-rotate-0
[346.688718] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.301s)
[346.813473] [067/132] (685s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[346.918237] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[346.930151] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[347.043353] [068/132] (685s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[347.153140] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[347.157051] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[347.262514] [069/132] (685s left) prime_mmap_kms (buffer-sharing)
[347.349246] Starting subtest: buffer-sharing
[347.815689] Subtest buffer-sharing: SUCCESS (0.463s)
[348.681578] [070/132] (684s left) kms_sequence (queue-busy)
[348.782901] Starting subtest: queue-busy
[348.785176] Starting dynamic subtest: pipe-A-eDP-1
[350.727231] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[350.738103] Starting dynamic subtest: pipe-B-eDP-1
[353.366598] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.640s)
[353.376701] Starting dynamic subtest: pipe-C-eDP-1
[355.970571] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.603s)
[355.980640] Starting dynamic subtest: pipe-D-eDP-1
[358.518092] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.543s)
[358.520364] Subtest queue-busy: SUCCESS (9.734s)
[359.325144] [071/132] (673s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[359.416498] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[359.420715] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[359.521018] [072/132] (673s left) gem_exec_schedule (u-submit-late-slice)
[359.597555] Starting subtest: u-submit-late-slice
[359.599593] Starting dynamic subtest: rcs0
[359.630104] Dynamic subtest rcs0: SUCCESS (0.040s)
[359.642907] Starting dynamic subtest: bcs0
[359.668947] Dynamic subtest bcs0: SUCCESS (0.038s)
[359.679097] Starting dynamic subtest: vcs0
[359.704303] Dynamic subtest vcs0: SUCCESS (0.034s)
[359.720125] Starting dynamic subtest: vcs1
[359.741504] Dynamic subtest vcs1: SUCCESS (0.037s)
[359.751879] Starting dynamic subtest: vecs0
[359.771731] Dynamic subtest vecs0: SUCCESS (0.029s)
[359.781713] Starting dynamic subtest: ccs0
[359.805051] Dynamic subtest ccs0: SUCCESS (0.032s)
[359.807302] Subtest u-submit-late-slice: SUCCESS (0.216s)
[361.001888] [073/132] (671s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[361.110021] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[361.114208] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[361.207734] [074/132] (671s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[361.255046] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[361.361380] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[361.462837] [075/132] (671s left) gem_render_linear_blits (basic)
[361.530109] Starting subtest: basic
[361.553281] Subtest basic: SUCCESS (0.023s)
[361.641656] [076/132] (671s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[361.732016] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[361.734233] Starting dynamic subtest: pipe-A
[362.068935] Dynamic subtest pipe-A: SUCCESS (0.338s)
[362.080462] Starting dynamic subtest: pipe-B
[363.503489] Dynamic subtest pipe-B: SUCCESS (1.432s)
[363.516229] Starting dynamic subtest: pipe-C
[364.928351] Dynamic subtest pipe-C: SUCCESS (1.423s)
[364.938885] Starting dynamic subtest: pipe-D
[366.377384] Dynamic subtest pipe-D: SUCCESS (1.447s)
[366.379661] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.648s)
[367.528936] [077/132] (665s left) syncobj_timeline (single-wait-for-submit-signaled)
[367.589636] Starting subtest: single-wait-for-submit-signaled
[367.591932] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[367.687898] [078/132] (665s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[367.797442] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[367.801913] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[367.903330] [079/132] (665s left) kms_psr (fbc-pr-primary-render)
[368.011038] Starting subtest: fbc-pr-primary-render
[368.015464] Subtest fbc-pr-primary-render: SKIP (0.000s)
[368.085424] [080/132] (665s left) gem_ctx_engines (execute-one)
[368.146594] Starting subtest: execute-one
[370.926386] Subtest execute-one: SUCCESS (2.779s)
[371.117772] [081/132] (662s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[371.225067] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[378.172268] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.948s)
[378.312529] [082/132] (655s left) gem_exec_capture (capture-invisible)
[378.377658] Starting subtest: capture-invisible
[378.380073] Starting dynamic subtest: smem0
[378.384512] Dynamic subtest smem0: SKIP (0.000s)
[378.388854] Subtest capture-invisible: SKIP (0.001s)
[378.490674] [083/132] (654s left) gem_eio (in-flight-immediate)
[378.729011] Starting subtest: in-flight-immediate
[386.850964] Subtest in-flight-immediate: SUCCESS (8.121s)
[386.971719] [084/132] (646s left) kms_cursor_crc (cursor-alpha-opaque)
[387.060729] Starting subtest: cursor-alpha-opaque
[387.062840] Starting dynamic subtest: pipe-A-eDP-1
[387.682497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[387.692641] Starting dynamic subtest: pipe-D-eDP-1
[388.970322] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.287s)
[388.972669] Subtest cursor-alpha-opaque: SUCCESS (1.910s)
[389.825223] [085/132] (643s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[389.881136] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[389.942157] [086/132] (643s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[389.999235] Starting subtest: y-tiled-ccs-to-x-tiled
[390.003720] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[390.197801] [087/132] (643s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[390.257806] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[390.259850] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[390.368926] [088/132] (643s left) perf (invalid-oa-exponent)
[390.472694] Starting subtest: invalid-oa-exponent
[390.484373] Subtest invalid-oa-exponent: SUCCESS (0.011s)
[390.533078] [089/132] (643s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[390.632034] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[390.634285] Starting dynamic subtest: pipe-A-default-mode
[393.400968] Dynamic subtest pipe-A-default-mode: SUCCESS (2.768s)
[393.403379] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.770s)
[394.231092] [090/132] (639s left) i915_selftest (mock)
[397.529777] Starting subtest: mock
[397.532550] Starting dynamic subtest: sanitycheck
[398.212221] Dynamic subtest sanitycheck: SUCCESS (0.683s)
[398.222484] Starting dynamic subtest: shmem
[398.884186] Dynamic subtest shmem: SUCCESS (0.670s)
[398.896343] Starting dynamic subtest: fence
[407.079406] Dynamic subtest fence: SUCCESS (8.192s)
[407.090137] Starting dynamic subtest: scatterlist
[408.750173] Dynamic subtest scatterlist: SUCCESS (1.669s)
[408.760229] Starting dynamic subtest: syncmap
[411.957571] Dynamic subtest syncmap: SUCCESS (3.205s)
[411.967933] Starting dynamic subtest: uncore
[412.635961] Dynamic subtest uncore: SUCCESS (0.678s)
[412.653237] Starting dynamic subtest: ring
[413.322927] Dynamic subtest ring: SUCCESS (0.685s)
[413.333383] Starting dynamic subtest: engine
[413.991141] Dynamic subtest engine: SUCCESS (0.666s)
[414.001491] Starting dynamic subtest: timelines
[417.871611] Dynamic subtest timelines: SUCCESS (3.877s)
[417.881278] Starting dynamic subtest: requests
[421.561673] Dynamic subtest requests: SUCCESS (3.689s)
[421.569662] Starting dynamic subtest: objects
[422.363227] Dynamic subtest objects: SUCCESS (0.801s)
[422.371366] Starting dynamic subtest: phys
[423.138248] Dynamic subtest phys: SUCCESS (0.773s)
[423.148690] Starting dynamic subtest: dmabuf
[423.919365] Dynamic subtest dmabuf: SUCCESS (0.779s)
[423.929677] Starting dynamic subtest: vma
[429.574052] Dynamic subtest vma: SUCCESS (5.652s)
[429.584071] Starting dynamic subtest: evict
[430.976355] Dynamic subtest evict: SUCCESS (1.401s)
[430.986345] Starting dynamic subtest: gtt
[434.300469] Dynamic subtest gtt: SUCCESS (3.322s)
[434.315865] Starting dynamic subtest: hugepages
[435.212890] Dynamic subtest hugepages: SUCCESS (0.911s)
[435.230191] Starting dynamic subtest: memory_region
[437.702229] Dynamic subtest memory_region: SUCCESS (2.487s)
[437.704773] Subtest mock: SUCCESS (40.172s)
[437.734231] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[437.734935] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[437.738071] [091/132] (596s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[439.296995] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[446.280671] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.985s)
[446.424076] [FACT kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[446.425837] [FACT kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[446.430012] [092/132] (587s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[446.536888] Starting subtest: fbc-psr-sprite-mmap-gtt
[446.539105] Starting dynamic subtest: eDP-1
[446.543173] Dynamic subtest eDP-1: SKIP (0.000s)
[446.547177] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[446.612351] [093/132] (587s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[446.749604] Starting subtest: dp-mst-type-1-suspend-resume
[446.754283] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[446.885738] [094/132] (586s left) kms_big_fb (x-tiled-addfb)
[446.992994] Starting subtest: x-tiled-addfb
[446.995314] Subtest x-tiled-addfb: SUCCESS (0.000s)
[447.098415] [095/132] (586s left) kms_big_fb (4-tiled-addfb-size-overflow)
[447.203425] Starting subtest: 4-tiled-addfb-size-overflow
[447.205635] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[447.303391] [096/132] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[447.403083] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[447.406381] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[447.500510] [097/132] (586s left) kms_lease (cursor-implicit-plane)
[447.596228] Starting subtest: cursor-implicit-plane
[447.598110] Starting dynamic subtest: pipe-A-eDP-1
[448.054677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s)
[448.065272] Starting dynamic subtest: pipe-B-eDP-1
[449.173721] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.116s)
[449.188721] Starting dynamic subtest: pipe-C-eDP-1
[450.276546] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.103s)
[450.286444] Starting dynamic subtest: pipe-D-eDP-1
[451.420385] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[451.422297] Subtest cursor-implicit-plane: SUCCESS (3.824s)
[452.278589] [098/132] (581s left) kms_fbcon_fbt (fbc-suspend)
[452.336909] Starting subtest: fbc-suspend
[501.868866] Subtest fbc-suspend: SUCCESS (19.361s)
[503.203885] [099/132] (530s left) gem_vm_create (create-ext)
[503.288856] Starting subtest: create-ext
[503.295265] Subtest create-ext: SUCCESS (0.006s)
[503.407674] [100/132] (530s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[503.508025] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[503.513151] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[503.595599] [101/132] (530s left) gem_mmap (bad-object)
[503.650872] Subtest bad-object: SKIP (0.000s)
[503.715971] [102/132] (530s left) gem_reg_read (timestamp-moving)
[503.779568] Starting subtest: timestamp-moving
[504.780258] Subtest timestamp-moving: SUCCESS (1.001s)
[504.860520] [103/132] (529s left) gem_pxp (display-protected-crc)
[504.985395] Starting subtest: display-protected-crc
[506.653966] Subtest display-protected-crc: SUCCESS (1.671s)
[506.763636] [104/132] (527s left) syncobj_timeline (invalid-signal-illegal-point)
[506.817241] Starting subtest: invalid-signal-illegal-point
[506.819947] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[506.913681] [105/132] (527s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[507.017295] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[507.019946] Starting dynamic subtest: pipe-A-default-mode
[509.763571] Dynamic subtest pipe-A-default-mode: SUCCESS (2.745s)
[509.766318] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.746s)
[510.635990] [106/132] (523s left) gem_partial_pwrite_pread (reads)
[510.696850] Subtest reads: SKIP (0.000s)
[510.767272] [107/132] (523s left) perf (gen12-unprivileged-single-ctx-counters)
[510.893201] Starting subtest: gen12-unprivileged-single-ctx-counters
[510.895768] Starting dynamic subtest: rcs0
[510.936270] Dynamic subtest rcs0: SUCCESS (0.043s)
[510.939282] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.044s)
[510.988453] [108/132] (523s left) kms_plane (plane-position-hole)
[511.108252] Starting subtest: plane-position-hole
[511.634754] Starting dynamic subtest: pipe-A-plane-1
[512.922565] Dynamic subtest pipe-A-plane-1: SUCCESS (1.288s)
[512.933030] Starting dynamic subtest: pipe-A-plane-2
[514.188099] Dynamic subtest pipe-A-plane-2: SUCCESS (1.264s)
[514.199041] Starting dynamic subtest: pipe-A-plane-3
[515.511924] Dynamic subtest pipe-A-plane-3: SUCCESS (1.323s)
[515.522362] Starting dynamic subtest: pipe-A-plane-4
[516.837311] Dynamic subtest pipe-A-plane-4: SUCCESS (1.326s)
[516.847136] Starting dynamic subtest: pipe-A-plane-5
[516.864239] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[518.017350] Starting dynamic subtest: pipe-B-plane-1
[519.365035] Dynamic subtest pipe-B-plane-1: SUCCESS (1.354s)
[519.375523] Starting dynamic subtest: pipe-B-plane-2
[520.713238] Dynamic subtest pipe-B-plane-2: SUCCESS (1.347s)
[520.722957] Starting dynamic subtest: pipe-B-plane-3
[522.014855] Dynamic subtest pipe-B-plane-3: SUCCESS (1.302s)
[522.027456] Starting dynamic subtest: pipe-B-plane-4
[523.320929] Dynamic subtest pipe-B-plane-4: SUCCESS (1.304s)
[523.331955] Starting dynamic subtest: pipe-B-plane-5
[523.346721] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[523.349050] Subtest plane-position-hole: SUCCESS (12.237s)
[524.118731] [109/132] (510s left) gem_exec_schedule (implicit-read-write)
[524.201982] Starting subtest: implicit-read-write
[524.204028] Starting dynamic subtest: rcs0
[524.302725] Dynamic subtest rcs0: SUCCESS (0.112s)
[524.315037] Starting dynamic subtest: vcs0
[524.385305] Dynamic subtest vcs0: SUCCESS (0.082s)
[524.398324] Starting dynamic subtest: vcs1
[524.461526] Dynamic subtest vcs1: SUCCESS (0.075s)
[524.473729] Starting dynamic subtest: vecs0
[524.537975] Dynamic subtest vecs0: SUCCESS (0.076s)
[524.549626] Starting dynamic subtest: ccs0
[524.627551] Dynamic subtest ccs0: SUCCESS (0.088s)
[524.630437] Subtest implicit-read-write: SUCCESS (0.437s)
[526.142791] [110/132] (508s left) gem_exec_flush (basic-batch-kernel-default-uc)
[526.213368] Starting subtest: basic-batch-kernel-default-uc
[532.936510] Subtest basic-batch-kernel-default-uc: SUCCESS (6.725s)
[533.139658] [111/132] (501s left) gem_ctx_persistence (heartbeat-stop)
[533.199289] Starting subtest: heartbeat-stop
[533.205326] Subtest heartbeat-stop: SKIP (0.000s)
[533.308485] [112/132] (501s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[533.514073] Starting subtest: cursor-rapid-movement-128x128
[533.517052] Starting dynamic subtest: pipe-A-eDP-1
[534.054941] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.536s)
[534.082772] Starting dynamic subtest: pipe-D-eDP-1
[535.229778] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.152s)
[535.232038] Subtest cursor-rapid-movement-128x128: SUCCESS (1.714s)
[536.094033] [113/132] (498s left) kms_cdclk (plane-scaling)
[536.185743] Starting subtest: plane-scaling
[536.188185] Starting dynamic subtest: pipe-A-eDP-1
[536.483019] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s)
[536.493282] Starting dynamic subtest: pipe-B-eDP-1
[536.499158] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[536.511717] Starting dynamic subtest: pipe-C-eDP-1
[536.517118] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[536.527183] Starting dynamic subtest: pipe-D-eDP-1
[536.533125] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[536.538517] Subtest plane-scaling: SKIP (0.301s)
[537.318576] [114/132] (497s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[537.412926] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[537.418326] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[537.487566] [115/132] (497s left) perf_pmu (idle)
[537.535896] Starting subtest: idle
[537.538268] Starting dynamic subtest: rcs0
[538.080034] Dynamic subtest rcs0: SUCCESS (0.543s)
[538.094419] Starting dynamic subtest: bcs0
[538.595746] Dynamic subtest bcs0: SUCCESS (0.513s)
[538.609645] Starting dynamic subtest: vcs0
[539.110781] Dynamic subtest vcs0: SUCCESS (0.513s)
[539.123591] Starting dynamic subtest: vcs1
[539.634662] Dynamic subtest vcs1: SUCCESS (0.521s)
[539.646427] Starting dynamic subtest: vecs0
[540.155270] Dynamic subtest vecs0: SUCCESS (0.514s)
[540.164995] Starting dynamic subtest: ccs0
[540.667099] Dynamic subtest ccs0: SUCCESS (0.513s)
[540.670130] Subtest idle: SUCCESS (3.133s)
[540.771864] [116/132] (494s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[540.873119] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[540.878738] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[540.944097] [117/132] (493s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[540.996852] Starting subtest: invalid-bsd1-flag-on-vebox
[540.999874] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[541.090909] [118/132] (493s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[541.182261] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[541.188560] Starting dynamic subtest: pipe-A-eDP-1
[542.503988] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.321s)
[542.784277] Starting dynamic subtest: pipe-B-eDP-1
[543.799199] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.025s)
[544.069127] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.888s)
[544.909531] [119/132] (490s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[545.015137] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[545.023396] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[545.108630] [120/132] (489s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[545.217117] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[545.221920] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[545.297866] [121/132] (489s left) gen7_exec_parse (basic-rejected)
[545.351626] Subtest basic-rejected: SKIP (0.000s)
[545.429460] [122/132] (489s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[545.519753] Starting subtest: psr2-cursor-plane-update-sf
[545.522033] Starting dynamic subtest: pipe-A-eDP-1
[546.082302] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[546.094258] Starting dynamic subtest: pipe-B-eDP-1
[547.394420] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.311s)
[547.397196] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.880s)
[548.266279] [123/132] (486s left) gem_exec_fence (syncobj-timeline-chain-engines)
[548.920808] Starting subtest: syncobj-timeline-chain-engines
[549.022884] Subtest syncobj-timeline-chain-engines: SUCCESS (0.103s)
[550.081378] [124/132] (485s left) gem_workarounds (reset-fd)
[550.157150] Starting subtest: reset-fd
[550.337849] Subtest reset-fd: SUCCESS (0.183s)
[550.457717] [125/132] (484s left) i915_module_load (resize-bar)
[550.495960] Starting subtest: resize-bar
[550.503301] Subtest resize-bar: SKIP (0.005s)
[550.551692] [126/132] (484s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[550.643091] Starting subtest: crc-primary-suspend-y-tiled-ccs
[550.646043] Starting dynamic subtest: pipe-A-eDP-1
[550.656715] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[550.669417] Starting dynamic subtest: pipe-B-eDP-1
[550.678455] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[550.687643] Starting dynamic subtest: pipe-C-eDP-1
[550.696688] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[550.705889] Starting dynamic subtest: pipe-D-eDP-1
[550.715007] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[550.719187] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[552.936695] [127/132] (482s left) syncobj_timeline (etime-single-wait-submitted)
[552.998085] Starting subtest: etime-single-wait-submitted
[553.105473] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[553.188097] [128/132] (482s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[553.309035] Starting subtest: short-busy-flip-before-cursor-toggle
[553.314197] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[553.459061] [129/132] (481s left) gem_pxp (reject-modify-context-protection-on)
[553.517941] Starting subtest: reject-modify-context-protection-on
[553.520542] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[553.660769] [130/132] (481s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[553.784003] Starting subtest: cursorB-vs-flipB-legacy
[553.789402] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[553.939284] [131/132] (481s left) kms_flip (busy-flip)
[554.032657] Starting subtest: busy-flip
[554.035262] Starting dynamic subtest: A-eDP1
[555.750570] Dynamic subtest A-eDP1: SUCCESS (1.717s)
[555.762103] Starting dynamic subtest: B-eDP1
[557.474500] Dynamic subtest B-eDP1: SUCCESS (1.722s)
[557.484979] Starting dynamic subtest: C-eDP1
[559.121491] Dynamic subtest C-eDP1: SUCCESS (1.645s)
[559.132383] Starting dynamic subtest: D-eDP1
[560.842975] Dynamic subtest D-eDP1: SUCCESS (1.719s)
[560.845666] Subtest busy-flip: SUCCESS (6.814s)
[562.005121] [132/132] (473s left) perf (whitelisted-registers-userspace-config)
[562.106611] Starting subtest: whitelisted-registers-userspace-config
[562.109323] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[562.148162] 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.