[102.669433] Initializing watchdogs
[102.669482]   /dev/watchdog0
[102.684540] [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]
[102.689104] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[102.691559] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[102.695539] [001/133] (960s left) kms_hdr (bpc-switch-dpms)
[102.806103] Starting subtest: bpc-switch-dpms
[103.908217] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[108.454902] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.544s)
[109.495223] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[114.021946] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.533s)
[114.024318] Subtest bpc-switch-dpms: SUCCESS (11.215s)
[114.132464] [002/133] (949s left) kms_psr (fbc-pr-cursor-render)
[114.242111] Starting subtest: fbc-pr-cursor-render
[114.246631] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[114.337183] [003/133] (948s left) kms_psr (fbc-psr-sprite-plane-onoff)
[114.429941] Starting subtest: fbc-psr-sprite-plane-onoff
[114.432246] Starting dynamic subtest: eDP-1
[114.436719] Dynamic subtest eDP-1: SKIP (0.000s)
[114.441327] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[114.497902] [004/133] (948s left) gem_mmap_gtt (fault-concurrent-x)
[114.558891] Subtest fault-concurrent-X: SKIP (0.000s)
[114.646513] [005/133] (948s left) kms_frontbuffer_tracking (fbc-1p-rte)
[114.746679] Starting subtest: fbc-1p-rte
[120.268586] Subtest fbc-1p-rte: SUCCESS (5.524s)
[121.489564] [006/133] (941s left) kms_pm_backlight (fade-with-dpms)
[121.578144] Starting subtest: fade-with-dpms
[123.737434] Starting dynamic subtest: eDP-1
[126.754451] Dynamic subtest eDP-1: SUCCESS (3.015s)
[126.756799] Subtest fade-with-dpms: SUCCESS (5.176s)
[127.629883] [007/133] (935s left) gem_exec_schedule (noreorder-priority)
[127.811916] Starting subtest: noreorder-priority
[127.814496] Starting dynamic subtest: rcs0
[128.944555] Dynamic subtest rcs0: SUCCESS (1.133s)
[128.956505] Starting dynamic subtest: vcs0
[130.307678] Dynamic subtest vcs0: SUCCESS (1.361s)
[130.317453] Starting dynamic subtest: vcs1
[132.289793] Dynamic subtest vcs1: SUCCESS (1.980s)
[132.298957] Starting dynamic subtest: vecs0
[134.284453] Dynamic subtest vecs0: SUCCESS (1.994s)
[134.294482] Starting dynamic subtest: ccs0
[135.423919] Dynamic subtest ccs0: SUCCESS (1.140s)
[135.426784] Subtest noreorder-priority: SUCCESS (7.612s)
[135.633686] [008/133] (927s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[135.743633] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[135.747871] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[135.842312] [009/133] (927s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[135.954380] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[142.876329] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.923s)
[143.008181] [010/133] (920s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[143.133332] Starting subtest: cursorB-vs-flipB-toggle
[143.137852] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[143.278657] [011/133] (920s left) kms_vblank (wait-forked)
[143.374388] Starting subtest: wait-forked
[143.376642] Starting dynamic subtest: pipe-A-eDP-1
[145.185265] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[145.200108] Starting dynamic subtest: pipe-D-eDP-1
[147.696776] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.507s)
[147.698847] Subtest wait-forked: SUCCESS (4.322s)
[148.576909] [012/133] (915s left) kms_pm_rpm (i2c)
[150.399027] Starting subtest: i2c
[155.473072] Subtest i2c: SUCCESS (5.077s)
[155.607602] [013/133] (908s left) kms_pwrite_crc (basic)
[155.700995] Starting subtest: basic
[156.381368] Subtest basic: SUCCESS (0.679s)
[157.176386] [014/133] (906s left) kms_content_protection (uevent-hdcp14)
[157.316063] Starting subtest: uevent-hdcp14
[157.320647] Subtest uevent-hdcp14: SKIP (0.000s)
[157.466936] [015/133] (906s left) perf (i915-ref-count)
[157.537576] Starting subtest: i915-ref-count
[157.600655] Subtest i915-ref-count: SUCCESS (0.061s)
[157.670818] [016/133] (906s left) kms_flip (2x-flip-vs-suspend)
[157.760299] Starting subtest: 2x-flip-vs-suspend
[157.764592] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[157.836511] [017/133] (906s left) sysfs_timeslice_duration (timeout)
[157.895770] Starting subtest: timeout
[157.898218] Starting dynamic subtest: vecs0
[167.303932] Dynamic subtest vecs0: SUCCESS (9.405s)
[167.314421] Starting dynamic subtest: ccs0
[168.520740] Dynamic subtest ccs0: SUCCESS (1.217s)
[168.531915] Starting dynamic subtest: vcs0
[178.312079] Dynamic subtest vcs0: SUCCESS (9.786s)
[178.323470] Starting dynamic subtest: bcs0
[178.872628] Dynamic subtest bcs0: SUCCESS (0.559s)
[178.883335] Starting dynamic subtest: rcs0
[180.117041] Dynamic subtest rcs0: SUCCESS (1.243s)
[180.127886] Starting dynamic subtest: vcs1
[189.312599] Dynamic subtest vcs1: SUCCESS (9.193s)
[189.315078] Subtest timeout: SUCCESS (31.415s)
[189.399445] [018/133] (874s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[189.504842] Starting subtest: y-tiled-32bpp-rotate-180
[189.509060] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[189.605822] [019/133] (874s left) i915_drm_fdinfo (busy-check-all)
[189.645775] Starting subtest: busy-check-all
[189.648234] Starting dynamic subtest: rcs0
[189.652823] Dynamic subtest rcs0: SKIP (0.003s)
[189.662814] Starting dynamic subtest: bcs0
[189.667188] Dynamic subtest bcs0: SKIP (0.000s)
[189.674961] Starting dynamic subtest: vcs0
[189.679559] Dynamic subtest vcs0: SKIP (0.000s)
[189.688097] Starting dynamic subtest: vcs1
[189.692504] Dynamic subtest vcs1: SKIP (0.000s)
[189.700613] Starting dynamic subtest: vecs0
[189.705069] Dynamic subtest vecs0: SKIP (0.000s)
[189.712950] Starting dynamic subtest: ccs0
[189.717382] Dynamic subtest ccs0: SKIP (0.000s)
[189.721815] Subtest busy-check-all: SKIP (0.007s)
[189.756992] [020/133] (874s left) perf_pmu (most-busy-idle-check-all)
[189.798304] Starting subtest: most-busy-idle-check-all
[189.800938] Starting dynamic subtest: rcs0
[191.303950] Dynamic subtest rcs0: SUCCESS (1.505s)
[191.316597] Starting dynamic subtest: bcs0
[193.287887] Dynamic subtest bcs0: SUCCESS (1.981s)
[193.297563] Starting dynamic subtest: vcs0
[195.272778] Dynamic subtest vcs0: SUCCESS (1.982s)
[195.284288] Starting dynamic subtest: vcs1
[197.319750] Dynamic subtest vcs1: SUCCESS (2.046s)
[197.331096] Starting dynamic subtest: vecs0
[199.303782] Dynamic subtest vecs0: SUCCESS (1.982s)
[199.315368] Starting dynamic subtest: ccs0
[201.287998] Dynamic subtest ccs0: SUCCESS (1.982s)
[201.290963] Subtest most-busy-idle-check-all: SUCCESS (11.490s)
[201.402672] [021/133] (862s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[201.521901] Starting subtest: cursorA-vs-flipA-legacy
[212.640752] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.118s)
[213.498423] [022/133] (850s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[213.617363] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[215.088670] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.469s)
[215.962236] [023/133] (848s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[216.052748] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[216.057174] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[216.132971] [024/133] (848s left) kms_dp_link_training (uhbr-sst)
[216.230764] Starting subtest: uhbr-sst
[216.239383] Subtest uhbr-sst: SKIP (0.000s)
[216.304833] [025/133] (847s left) kms_plane_lowres (tiling-y)
[216.391032] Starting subtest: tiling-y
[216.395346] Subtest tiling-y: SKIP (0.000s)
[216.457299] [026/133] (847s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[216.549954] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[216.552275] Starting dynamic subtest: pipe-A-eDP-1
[216.561400] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[216.570832] Starting dynamic subtest: pipe-B-eDP-1
[216.579988] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[216.588985] Starting dynamic subtest: pipe-C-eDP-1
[216.597337] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[216.605527] Starting dynamic subtest: pipe-D-eDP-1
[216.614165] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[216.619069] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[218.825313] [027/133] (845s left) gem_exec_schedule (fairslice)
[218.902061] Starting subtest: fairslice
[218.904091] Starting dynamic subtest: rcs0
[220.919731] Dynamic subtest rcs0: SUCCESS (2.024s)
[220.930235] Starting dynamic subtest: bcs0
[222.940551] Dynamic subtest bcs0: SUCCESS (2.019s)
[222.949204] Starting dynamic subtest: vcs0
[224.960664] Dynamic subtest vcs0: SUCCESS (2.020s)
[224.971607] Starting dynamic subtest: vcs1
[227.002703] Dynamic subtest vcs1: SUCCESS (2.018s)
[227.012707] Starting dynamic subtest: vecs0
[229.000682] Dynamic subtest vecs0: SUCCESS (2.021s)
[229.010061] Starting dynamic subtest: ccs0
[231.024872] Dynamic subtest ccs0: SUCCESS (2.022s)
[231.026854] Subtest fairslice: SUCCESS (12.127s)
[231.321712] [028/133] (833s left) kms_cdclk (mode-transition-all-outputs)
[231.419961] Starting subtest: mode-transition-all-outputs
[231.712644] Subtest mode-transition-all-outputs: SKIP (0.291s)
[232.552110] [029/133] (831s left) kms_chamelium_hpd (hdmi-hpd-storm)
[232.939733] Subtest hdmi-hpd-storm: SKIP (0.000s)
[233.773010] [030/133] (830s left) kms_invalid_mode (bad-htotal)
[233.859578] Starting subtest: bad-htotal
[233.861913] Starting dynamic subtest: pipe-A-eDP-1
[234.149266] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[234.158702] Starting dynamic subtest: pipe-B-eDP-1
[234.160612] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[234.168500] Starting dynamic subtest: pipe-C-eDP-1
[234.170425] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[234.178643] Starting dynamic subtest: pipe-D-eDP-1
[234.180968] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[234.183330] Subtest bad-htotal: SUCCESS (0.299s)
[235.028502] [031/133] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[235.141768] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[235.146969] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[235.238379] [032/133] (829s left) dumb_buffer (invalid-bpp)
[235.296241] Starting subtest: invalid-bpp
[235.298254] Subtest invalid-bpp: SUCCESS (0.000s)
[235.389963] [033/133] (829s left) kms_color_pipeline (plane-ctm3x4)
[235.475065] Starting subtest: plane-ctm3x4
[235.621283] Starting dynamic subtest: pipe-A-plane-0
[235.787656] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[235.796720] Starting dynamic subtest: pipe-A-plane-1
[235.921217] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[235.931837] Starting dynamic subtest: pipe-A-plane-2
[236.056164] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[237.217158] Starting dynamic subtest: pipe-B-plane-0
[237.377735] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[237.388690] Starting dynamic subtest: pipe-B-plane-1
[237.508904] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[237.518880] Starting dynamic subtest: pipe-B-plane-2
[237.643251] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[238.839124] Starting dynamic subtest: pipe-C-plane-0
[238.943198] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[238.953847] Starting dynamic subtest: pipe-C-plane-1
[239.087650] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[239.099606] Starting dynamic subtest: pipe-C-plane-2
[239.199068] Dynamic subtest pipe-C-plane-2: SUCCESS (0.111s)
[240.381587] Starting dynamic subtest: pipe-D-plane-0
[240.507087] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[240.517553] Starting dynamic subtest: pipe-D-plane-1
[240.640669] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[240.653076] Starting dynamic subtest: pipe-D-plane-2
[240.751477] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[241.041557] Subtest plane-ctm3x4: SUCCESS (5.566s)
[241.841960] [034/133] (822s left) kms_psr (psr2-sprite-mmap-gtt)
[241.939883] Starting subtest: psr2-sprite-mmap-gtt
[241.942297] Starting dynamic subtest: eDP-1
[243.350854] Dynamic subtest eDP-1: SKIP (1.407s)
[243.355883] Subtest psr2-sprite-mmap-gtt: SKIP (1.409s)
[243.479481] [035/133] (821s left) kms_chamelium_frames (hdmi-crc-fast)
[243.863365] Subtest hdmi-crc-fast: SKIP (0.000s)
[244.692866] [036/133] (819s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[244.782486] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[244.784803] Starting dynamic subtest: pipe-A-eDP-1
[244.806877] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[244.817385] Starting dynamic subtest: pipe-B-eDP-1
[244.837921] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[244.846233] Starting dynamic subtest: pipe-C-eDP-1
[244.866830] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[244.874724] Starting dynamic subtest: pipe-D-eDP-1
[244.896337] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[244.900755] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[247.106750] [037/133] (817s left) kms_lease (lease-uevent)
[247.198229] Starting subtest: lease-uevent
[248.216219] Subtest lease-uevent: SUCCESS (1.019s)
[248.312602] [038/133] (816s left) i915_pm_freq_api (freq-reset)
[248.374882] Starting subtest: freq-reset
[248.377315] Starting dynamic subtest: gt0
[248.562671] Dynamic subtest gt0: SUCCESS (0.187s)
[248.572670] Starting dynamic subtest: gt1
[248.728023] Dynamic subtest gt1: SUCCESS (0.160s)
[248.730894] Subtest freq-reset: SUCCESS (0.348s)
[248.809206] [039/133] (816s left) gem_exec_capture (capture-invisible)
[248.866298] Starting subtest: capture-invisible
[248.868515] Starting dynamic subtest: smem0
[248.872588] Dynamic subtest smem0: SKIP (0.000s)
[248.876615] Subtest capture-invisible: SKIP (0.001s)
[248.973546] [040/133] (815s left) sw_sync (sync_busy_fork_unixsocket)
[249.006680] Starting subtest: sync_busy_fork_unixsocket
[249.011996] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[249.066397] [041/133] (815s left) gem_compute (compute-square)
[249.119253] Starting subtest: compute-square
[249.124257] Subtest compute-square: SUCCESS (0.007s)
[249.247229] [042/133] (815s left) kms_psr (pr-primary-blt)
[249.333329] Starting subtest: pr-primary-blt
[249.337682] Subtest pr-primary-blt: SKIP (0.000s)
[249.404382] [043/133] (815s left) kms_setmode (basic)
[249.452780] Starting subtest: basic
[249.771132] Starting dynamic subtest: pipe-A-eDP-1
[251.900907] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.125s)
[252.244879] Starting dynamic subtest: pipe-B-eDP-1
[254.334663] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.092s)
[254.648220] Subtest basic: SUCCESS (5.195s)
[255.477531] [044/133] (809s left) kms_big_fb (linear-64bpp-rotate-0)
[255.584591] Starting subtest: linear-64bpp-rotate-0
[257.218084] Subtest linear-64bpp-rotate-0: SUCCESS (1.634s)
[257.407022] [045/133] (807s left) gem_mmap_offset (partial-remap)
[257.460450] Starting subtest: partial-remap
[257.462881] Starting dynamic subtest: smem0
[257.471766] Dynamic subtest smem0: SUCCESS (0.004s)
[257.473791] Subtest partial-remap: SUCCESS (0.004s)
[257.593043] [046/133] (807s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[257.688518] Starting subtest: 4-tiled-64bpp-rotate-270
[257.711084] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.022s)
[257.846460] [047/133] (807s left) dumb_buffer (map-valid)
[257.899031] Starting subtest: map-valid
[257.900747] Subtest map-valid: SUCCESS (0.000s)
[258.002818] [048/133] (807s left) perf (invalid-remove-userspace-config)
[258.088232] Starting subtest: invalid-remove-userspace-config
[258.095254] Subtest invalid-remove-userspace-config: SUCCESS (0.007s)
[258.145229] [049/133] (807s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[258.239712] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[265.653710] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.415s)
[265.801104] [050/133] (799s left) api_intel_bb (object-noreloc-purge-cache-simple)
[265.847542] Starting subtest: object-noreloc-purge-cache-simple
[265.849586] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[265.989014] [051/133] (799s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[266.089036] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[266.114873] Starting dynamic subtest: pipe-A-plane-0
[266.770985] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[266.780475] Starting dynamic subtest: pipe-A-plane-3
[267.192225] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[268.291675] Starting dynamic subtest: pipe-B-plane-0
[268.947287] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s)
[268.957733] Starting dynamic subtest: pipe-B-plane-3
[269.379743] Dynamic subtest pipe-B-plane-3: SUCCESS (0.431s)
[269.689563] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.602s)
[270.553894] [052/133] (794s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[270.660880] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[270.663364] Starting dynamic subtest: pipe-A
[270.682658] Dynamic subtest pipe-A: SKIP (0.017s)
[270.692444] Starting dynamic subtest: pipe-B
[270.713275] Dynamic subtest pipe-B: SKIP (0.032s)
[270.723153] Starting dynamic subtest: pipe-C
[270.746167] Dynamic subtest pipe-C: SKIP (0.032s)
[270.755845] Starting dynamic subtest: pipe-D
[270.780292] Dynamic subtest pipe-D: SKIP (0.032s)
[270.784796] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.116s)
[270.871406] [053/133] (794s left) gem_eio (in-flight-contexts-10ms)
[271.107200] Starting subtest: in-flight-contexts-10ms
[282.354683] Subtest in-flight-contexts-10ms: SUCCESS (11.247s)
[282.504669] [054/133] (782s left) gem_ctx_param (set-priority-invalid-size)
[282.562721] Starting subtest: set-priority-invalid-size
[282.565039] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[282.642718] [055/133] (782s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[282.737057] Starting subtest: primary-yf-tiled-reflect-x-0
[282.796598] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[282.899752] [056/133] (782s left) gem_render_tiled_blits (basic)
[282.950450] Subtest basic: SKIP (0.000s)
[283.010219] [057/133] (782s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[283.107972] Starting subtest: psr-rgb101010-draw-mmap-gtt
[283.112048] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[283.203250] [058/133] (782s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[283.290797] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[283.293034] Starting dynamic subtest: pipe-A-eDP-1
[283.317814] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[283.334503] Starting dynamic subtest: pipe-B-eDP-1
[283.351996] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[283.360633] Starting dynamic subtest: pipe-C-eDP-1
[283.378896] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[283.387331] Starting dynamic subtest: pipe-D-eDP-1
[283.405893] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[283.409380] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[285.528591] [059/133] (780s left) syncobj_basic (create-signaled)
[285.581061] Starting subtest: create-signaled
[285.582918] Subtest create-signaled: SUCCESS (0.000s)
[285.693486] [060/133] (779s left) gem_exec_schedule (u-semaphore-resolve)
[285.754309] Starting subtest: u-semaphore-resolve
[285.789424] Subtest u-semaphore-resolve: SUCCESS (0.042s)
[286.124481] [061/133] (779s left) prime_busy (before-wait)
[286.182593] Starting subtest: before-wait
[286.187748] Starting dynamic subtest: rcs0
[286.226817] Dynamic subtest rcs0: SUCCESS (0.041s)
[286.238242] Starting dynamic subtest: bcs0
[286.266805] Dynamic subtest bcs0: SUCCESS (0.039s)
[286.276134] Starting dynamic subtest: vcs0
[286.305960] Dynamic subtest vcs0: SUCCESS (0.038s)
[286.315136] Starting dynamic subtest: vcs1
[286.346136] Dynamic subtest vcs1: SUCCESS (0.039s)
[286.355216] Starting dynamic subtest: vecs0
[286.386592] Dynamic subtest vecs0: SUCCESS (0.039s)
[286.395786] Starting dynamic subtest: ccs0
[286.425047] Dynamic subtest ccs0: SUCCESS (0.038s)
[286.533554] Subtest before-wait: SUCCESS (0.349s)
[286.623109] [062/133] (779s left) gem_ctx_persistence (legacy-engines-mixed-process)
[286.672781] Starting subtest: legacy-engines-mixed-process
[286.674839] Starting dynamic subtest: render
[288.340161] Dynamic subtest render: SUCCESS (1.670s)
[288.354305] Starting dynamic subtest: bsd1
[290.329978] Dynamic subtest bsd1: SUCCESS (1.987s)
[290.341072] Starting dynamic subtest: bsd2
[292.312110] Dynamic subtest bsd2: SUCCESS (1.980s)
[292.323754] Starting dynamic subtest: blt
[294.265145] Dynamic subtest blt: SUCCESS (1.948s)
[294.276027] Starting dynamic subtest: vebox
[296.346756] Dynamic subtest vebox: SUCCESS (2.083s)
[296.349084] Subtest legacy-engines-mixed-process: SUCCESS (9.678s)
[296.426009] [063/133] (769s left) gem_exec_params (batch-first)
[296.483028] Starting subtest: batch-first
[296.492049] Subtest batch-first: SUCCESS (0.009s)
[296.595886] [064/133] (769s left) kms_feature_discovery (psr1)
[296.693072] Starting subtest: psr1
[296.695246] Subtest psr1: SUCCESS (0.000s)
[296.767505] [065/133] (769s left) gem_render_copy_redux (flink)
[296.826479] Starting subtest: flink
[297.654102] Subtest flink: SUCCESS (0.829s)
[297.743743] [066/133] (768s left) kms_plane_cursor (overlay)
[297.830414] Starting subtest: overlay
[297.834073] Starting dynamic subtest: pipe-A-eDP-1-size-64
[300.415606] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.585s)
[300.474489] Starting dynamic subtest: pipe-A-eDP-1-size-128
[303.051148] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s)
[303.111232] Starting dynamic subtest: pipe-A-eDP-1-size-256
[305.718172] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.616s)
[306.073219] Starting dynamic subtest: pipe-B-eDP-1-size-64
[309.374368] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.312s)
[309.435713] Starting dynamic subtest: pipe-B-eDP-1-size-128
[311.997085] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.571s)
[312.058437] Starting dynamic subtest: pipe-B-eDP-1-size-256
[314.621258] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.571s)
[314.978276] Starting dynamic subtest: pipe-C-eDP-1-size-64
[317.884485] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.918s)
[317.921964] Starting dynamic subtest: pipe-C-eDP-1-size-128
[320.106488] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s)
[320.145285] Starting dynamic subtest: pipe-C-eDP-1-size-256
[322.341073] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[322.668345] Starting dynamic subtest: pipe-D-eDP-1-size-64
[325.603359] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.948s)
[325.642325] Starting dynamic subtest: pipe-D-eDP-1-size-128
[327.859341] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.225s)
[327.897286] Starting dynamic subtest: pipe-D-eDP-1-size-256
[330.104398] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[330.422875] Subtest overlay: SUCCESS (32.589s)
[331.249410] [067/133] (734s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[331.350594] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[331.355066] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[331.448583] [068/133] (734s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[331.548613] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[331.553142] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[331.646754] [069/133] (734s left) gem_exec_balancer (bonded-chain)
[331.722463] Starting subtest: bonded-chain
[338.738838] Subtest bonded-chain: SUCCESS (7.017s)
[339.066930] [070/133] (727s left) kms_atomic_interruptible (legacy-cursor)
[339.170263] Starting subtest: legacy-cursor
[339.172606] Starting dynamic subtest: pipe-A-eDP-1
[346.556842] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.385s)
[346.559036] Subtest legacy-cursor: SUCCESS (7.386s)
[347.407376] [071/133] (718s left) kms_sequence (get-forked-busy)
[347.500189] Starting subtest: get-forked-busy
[347.502399] Starting dynamic subtest: pipe-A-eDP-1
[349.437365] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s)
[349.447787] Starting dynamic subtest: pipe-B-eDP-1
[352.001633] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.564s)
[352.011864] Starting dynamic subtest: pipe-C-eDP-1
[354.617397] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.612s)
[354.626883] Starting dynamic subtest: pipe-D-eDP-1
[357.242606] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.625s)
[357.244932] Subtest get-forked-busy: SUCCESS (9.743s)
[358.027961] [072/133] (708s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[358.087241] Starting subtest: etime-single-wait-for-submit-submitted
[358.195919] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[358.301105] [073/133] (707s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[358.396170] Starting subtest: x-tiled-16bpp-rotate-270
[358.419277] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s)
[358.544085] [074/133] (707s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[358.635082] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[358.639255] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[358.716499] [075/133] (707s left) syncobj_wait (single-wait-all-submitted)
[358.769766] Starting subtest: single-wait-all-submitted
[358.875493] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[358.963052] [076/133] (707s left) gem_workarounds (suspend-resume-fd)
[359.016916] Starting subtest: suspend-resume-fd
[375.589886] Subtest suspend-resume-fd: SUCCESS (1.312s)
[375.732971] [077/133] (690s left) gem_userptr_blits (invalid-null-pointer)
[375.819723] Starting subtest: invalid-null-pointer
[375.821803] Subtest invalid-null-pointer: SUCCESS (0.002s)
[375.946555] [078/133] (690s left) syncobj_timeline (multi-wait-submitted-signaled)
[375.998740] Starting subtest: multi-wait-submitted-signaled
[376.001061] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[376.113947] [079/133] (690s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[376.207306] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[382.993470] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.002s)
[383.138016] [080/133] (683s left) gem_exec_create (madvise)
[383.205744] Starting subtest: madvise
[383.208109] Starting dynamic subtest: smem
[403.354035] Dynamic subtest smem: SUCCESS (20.286s)
[403.359858] Subtest madvise: SUCCESS (20.287s)
[404.072175] [081/133] (662s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[404.177904] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[411.743540] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.570s)
[411.869045] [082/133] (654s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[411.919010] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[411.964471] [083/133] (654s left) kms_cursor_edge_walk (256x256-left-edge)
[412.056379] Starting subtest: 256x256-left-edge
[412.058561] Starting dynamic subtest: pipe-A-eDP-1
[415.519094] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.461s)
[415.530452] Starting dynamic subtest: pipe-D-eDP-1
[418.633202] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[418.635480] Subtest 256x256-left-edge: SUCCESS (6.576s)
[419.481144] [084/133] (647s left) gem_ctx_param (vm)
[419.539386] Starting subtest: vm
[419.587219] Subtest vm: SUCCESS (0.051s)
[419.742397] [085/133] (646s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[419.841490] Starting subtest: fbc-psr2-cursor-plane-update-sf
[419.843864] Starting dynamic subtest: pipe-A-eDP-1
[419.918089] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[419.929597] Starting dynamic subtest: pipe-B-eDP-1
[421.019782] Dynamic subtest pipe-B-eDP-1: SKIP (1.100s)
[421.024083] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.181s)
[422.221157] [086/133] (644s left) gem_exec_fence (syncobj-invalid-flags)
[422.698087] Starting subtest: syncobj-invalid-flags
[422.700619] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[424.623683] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[424.627016] [087/133] (642s left) gem_exec_schedule (smoketest-all)
[424.703566] Starting subtest: smoketest-all
[457.095886] Subtest smoketest-all: SUCCESS (32.357s)
[458.624698] [088/133] (608s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[458.687850] Starting subtest: single-wait-all-for-submit-signaled
[458.690229] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[458.776979] [089/133] (608s left) gem_madvise (dontneed-before-pwrite)
[458.811302] Starting subtest: dontneed-before-pwrite
[458.833022] Subtest dontneed-before-pwrite: SKIP (0.018s)
[458.905864] [090/133] (608s left) kms_cursor_crc (cursor-sliding-128x42)
[459.135946] Starting subtest: cursor-sliding-128x42
[459.185904] Subtest cursor-sliding-128x42: SKIP (0.044s)
[459.373547] [091/133] (607s left) gem_ctx_param (invalid-ctx-set)
[459.425480] Starting subtest: invalid-ctx-set
[459.427924] Subtest invalid-ctx-set: SUCCESS (0.001s)
[459.519594] [092/133] (607s left) gem_exec_store (pages)
[459.577442] Starting subtest: pages
[459.579267] Starting dynamic subtest: rcs0
[459.673198] Dynamic subtest rcs0: SUCCESS (0.095s)
[459.686353] Starting dynamic subtest: bcs0
[459.747683] Dynamic subtest bcs0: SUCCESS (0.073s)
[459.760183] Starting dynamic subtest: vcs0
[459.818342] Dynamic subtest vcs0: SUCCESS (0.070s)
[459.831168] Starting dynamic subtest: vcs1
[459.889405] Dynamic subtest vcs1: SUCCESS (0.070s)
[459.900727] Starting dynamic subtest: vecs0
[459.961354] Dynamic subtest vecs0: SUCCESS (0.071s)
[459.972357] Starting dynamic subtest: ccs0
[460.032489] Dynamic subtest ccs0: SUCCESS (0.070s)
[460.034463] Subtest pages: SUCCESS (0.456s)
[460.229424] [093/133] (606s left) i915_query (query-garbage)
[460.291071] Starting subtest: query-garbage
[460.293437] Subtest query-garbage: SUCCESS (0.000s)
[460.395057] [094/133] (606s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[460.485926] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[461.264900] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s)
[461.440970] [095/133] (605s left) i915_pm_rpm (gem-execbuf-stress)
[463.781789] Starting subtest: gem-execbuf-stress
[463.783982] Starting dynamic subtest: smem0
[476.709648] Dynamic subtest smem0: SUCCESS (12.936s)
[476.723450] Starting dynamic subtest: extra-wait-smem0
[538.511195] Dynamic subtest extra-wait-smem0: SUCCESS (61.827s)
[538.514253] Subtest gem-execbuf-stress: SUCCESS (74.770s)
[538.900728] [096/133] (528s left) gem_userptr_blits (process-exit)
[538.966659] Starting subtest: process-exit
[538.971923] Subtest process-exit: SUCCESS (0.007s)
[539.085962] [097/133] (528s left) gem_exec_suspend (basic)
[539.143368] Starting subtest: basic
[539.145891] Starting dynamic subtest: smem
[540.576502] Dynamic subtest smem: SUCCESS (1.431s)
[540.579387] Subtest basic: SUCCESS (1.433s)
[540.773599] [098/133] (526s left) gen9_exec_parse (batch-zero-length)
[540.825171] Subtest batch-zero-length: SKIP (0.000s)
[540.900355] [099/133] (526s left) api_intel_bb (blit-reloc-purge-cache)
[540.951187] Starting subtest: blit-reloc-purge-cache
[540.955020] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[541.081572] [100/133] (526s left) gem_exec_params (no-blt)
[541.135736] Starting subtest: no-blt
[541.137899] Subtest no-blt: SUCCESS (0.002s)
[541.244830] [101/133] (526s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[541.290377] Starting subtest: multi-wait-all-for-submit-available-signaled
[541.292728] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[541.407934] [102/133] (526s left) kms_addfb_basic (size-max)
[541.501358] Starting subtest: size-max
[541.503546] Subtest size-max: SUCCESS (0.000s)
[541.606540] [103/133] (525s left) kms_plane_scaling (planes-downscale-factor-0-5)
[541.692346] Starting subtest: planes-downscale-factor-0-5
[541.694702] Starting dynamic subtest: pipe-A
[541.712827] Dynamic subtest pipe-A: SKIP (0.018s)
[541.723668] Starting dynamic subtest: pipe-B
[541.747887] Dynamic subtest pipe-B: SKIP (0.033s)
[541.759779] Starting dynamic subtest: pipe-C
[541.782306] Dynamic subtest pipe-C: SKIP (0.033s)
[541.792655] Starting dynamic subtest: pipe-D
[541.814909] Dynamic subtest pipe-D: SKIP (0.033s)
[541.817994] Subtest planes-downscale-factor-0-5: SKIP (0.121s)
[541.914495] [104/133] (525s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[542.024890] Starting subtest: flip-vs-cursor-crc-atomic
[542.729494] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.702s)
[543.630967] [105/133] (523s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[543.736431] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[552.403562] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.674s)
[552.516971] [106/133] (515s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[552.610317] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[552.614279] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[552.689743] [107/133] (514s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[552.793248] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[552.797680] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[552.911952] [108/133] (514s left) gem_softpin (32b-excludes-last-page)
[552.967136] Starting subtest: 32b-excludes-last-page
[552.972032] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[553.106671] [109/133] (514s left) gem_watchdog (default-virtual)
[553.182840] Starting subtest: default-virtual
[559.457240] Subtest default-virtual: SUCCESS (6.285s)
[559.564301] [110/133] (508s left) gem_mmap_gtt (basic-small-bo-tiledx)
[559.615009] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[559.678588] [111/133] (508s left) gem_render_copy (yf-tiled-ccs-to-linear)
[559.739478] Starting subtest: yf-tiled-ccs-to-linear
[559.743691] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[559.946497] [112/133] (507s left) kms_atomic (plane-overlay-legacy)
[560.055253] Starting subtest: plane-overlay-legacy
[560.057516] Starting dynamic subtest: pipe-A-eDP-1
[560.483662] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s)
[560.485798] Subtest plane-overlay-legacy: SUCCESS (0.428s)
[561.366133] [113/133] (506s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[561.463758] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[561.468126] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[561.573465] [114/133] (506s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[561.677840] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[561.682078] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[561.775094] [115/133] (506s left) gem_readwrite (read-bad-handle)
[561.831115] Subtest read-bad-handle: SKIP (0.000s)
[561.896300] [116/133] (506s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[561.992844] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[561.996788] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[562.092134] [117/133] (506s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[562.153481] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[562.236113] [118/133] (505s left) kms_cursor_crc (cursor-onscreen-256x256)
[562.468931] Starting subtest: cursor-onscreen-256x256
[562.475721] Starting dynamic subtest: pipe-A-eDP-1
[564.574381] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.098s)
[564.607175] Starting dynamic subtest: pipe-D-eDP-1
[567.347606] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.753s)
[567.349955] Subtest cursor-onscreen-256x256: SUCCESS (4.881s)
[568.233023] [119/133] (499s left) kms_async_flips (async-flip-suspend-resume)
[568.331526] Starting subtest: async-flip-suspend-resume
[568.708140] Starting dynamic subtest: pipe-A-eDP-1
[586.568687] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.909s)
[586.941145] Starting dynamic subtest: pipe-B-eDP-1
[604.565016] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.984s)
[604.949500] Starting dynamic subtest: pipe-C-eDP-1
[622.570633] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.968s)
[622.943248] Starting dynamic subtest: pipe-D-eDP-1
[640.581245] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.967s)
[640.584028] Subtest async-flip-suspend-resume: SUCCESS (13.331s)
[641.729882] [120/133] (426s left) gem_exec_balancer (fairslice)
[641.784319] Starting subtest: fairslice
[644.704893] Subtest fairslice: SUCCESS (3.018s)
[645.017761] [121/133] (423s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[645.113196] Starting subtest: plane-all-transition-nonblocking-fencing
[645.115778] Starting dynamic subtest: pipe-A-eDP-1
[647.554930] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[647.858215] Starting dynamic subtest: pipe-B-eDP-1
[651.038914] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.241s)
[651.354233] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.351s)
[652.163902] [122/133] (416s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[652.267110] Starting subtest: psr2-cursor-plane-update-sf
[652.269336] Starting dynamic subtest: pipe-A-eDP-1
[652.829365] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[652.840924] Starting dynamic subtest: pipe-B-eDP-1
[654.122961] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.303s)
[654.125583] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.880s)
[654.997573] [123/133] (413s left) i915_selftest (perf)
[656.806762] Starting subtest: perf
[656.808972] Starting dynamic subtest: engine_cs
[660.458249] Dynamic subtest engine_cs: SUCCESS (3.669s)
[660.466660] Starting dynamic subtest: request
[666.588083] Dynamic subtest request: SUCCESS (6.145s)
[666.602256] Starting dynamic subtest: migrate
[670.351087] Dynamic subtest migrate: SUCCESS (3.767s)
[670.361462] Starting dynamic subtest: region
[675.609182] Dynamic subtest region: SUCCESS (5.252s)
[675.612288] Subtest perf: SUCCESS (18.838s)
[675.642641] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[675.643381] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[675.647337] [124/133] (392s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[678.114064] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[678.118887] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[678.220221] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[678.221591] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[678.226298] [125/133] (390s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[678.319663] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[678.324556] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[678.421222] [126/133] (390s left) gem_softpin (full)
[678.477367] Starting subtest: full
[678.489085] Subtest full: SUCCESS (0.012s)
[678.617813] [127/133] (389s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[678.705908] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[678.708314] Starting dynamic subtest: pipe-A-eDP-1
[678.731198] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[678.743000] Starting dynamic subtest: pipe-B-eDP-1
[678.765972] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[678.775258] Starting dynamic subtest: pipe-C-eDP-1
[678.797825] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[678.807068] Starting dynamic subtest: pipe-D-eDP-1
[678.829885] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[678.832094] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[680.995947] [128/133] (387s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[681.093365] Starting subtest: fbc-psr2-sprite-mmap-cpu
[681.096157] Starting dynamic subtest: eDP-1
[681.101422] Dynamic subtest eDP-1: SKIP (0.000s)
[681.106990] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[681.169459] [129/133] (387s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[681.281179] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[713.468085] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (32.186s)
[714.324937] [130/133] (354s left) perf (gen12-group-concurrent-oa-buffer-read)
[714.457176] Starting subtest: gen12-group-concurrent-oa-buffer-read
[724.487023] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.031s)
[724.539696] [131/133] (344s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[724.661782] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[724.666754] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[724.805926] [132/133] (343s left) syncobj_eventfd (timeline-wait-before-signal)
[724.858213] Starting subtest: timeline-wait-before-signal
[724.888185] Subtest timeline-wait-before-signal: SUCCESS (0.032s)
[724.968430] [133/133] (343s left) gem_mmap_wc (pf-nonblock)
[725.019203] Subtest pf-nonblock: SKIP (0.000s)
[725.069901] Closing watchdogs
results: parsing output: 0/ for test: kms_hdr
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_pm_backlight
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_vblank
results: parsing output: 11/ for test: kms_pm_rpm
results: parsing output: 12/ for test: kms_pwrite_crc
results: parsing output: 13/ for test: kms_content_protection
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: sysfs_timeslice_duration
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_dp_link_training
results: parsing output: 24/ for test: kms_plane_lowres
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_cdclk
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: kms_invalid_mode
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: dumb_buffer
results: parsing output: 32/ for test: kms_color_pipeline
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_chamelium_frames
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_lease
results: parsing output: 37/ for test: i915_pm_freq_api
results: parsing output: 38/ for test: gem_exec_capture
results: parsing output: 39/ for test: sw_sync
results: parsing output: 40/ for test: gem_compute
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_setmode
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_mmap_offset
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: dumb_buffer
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: api_intel_bb
results: parsing output: 50/ for test: kms_plane
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: gem_eio
results: parsing output: 53/ for test: gem_ctx_param
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: gem_render_tiled_blits
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: syncobj_basic
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: prime_busy
results: parsing output: 61/ for test: gem_ctx_persistence
results: parsing output: 62/ for test: gem_exec_params
results: parsing output: 63/ for test: kms_feature_discovery
results: parsing output: 64/ for test: gem_render_copy_redux
results: parsing output: 65/ for test: kms_plane_cursor
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_exec_balancer
results: parsing output: 69/ for test: kms_atomic_interruptible
results: parsing output: 70/ for test: kms_sequence
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: gem_workarounds
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_create
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_lmem_swapping
results: parsing output: 82/ for test: kms_cursor_edge_walk
results: parsing output: 83/ for test: gem_ctx_param
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_madvise
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: gem_ctx_param
results: parsing output: 91/ for test: gem_exec_store
results: parsing output: 92/ for test: i915_query
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: i915_pm_rpm
results: parsing output: 95/ for test: gem_userptr_blits
results: parsing output: 96/ for test: gem_exec_suspend
results: parsing output: 97/ for test: gen9_exec_parse
results: parsing output: 98/ for test: api_intel_bb
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_softpin
results: parsing output: 108/ for test: gem_watchdog
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_atomic
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_readwrite
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_fenced_exec_thrash
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_async_flips
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: kms_atomic_transition
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: i915_selftest
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: syncobj_eventfd
results: parsing output: 132/ for test: gem_mmap_wc
Done.