[63.406184] Initializing watchdogs
[63.406234]   /dev/watchdog0
[63.420276] [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]
[63.425277] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.427645] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.430984] [001/133] (960s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[63.562338] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[63.601361] Starting dynamic subtest: pipe-A-plane-0
[64.071649] Dynamic subtest pipe-A-plane-0: SUCCESS (0.467s)
[64.080247] Starting dynamic subtest: pipe-A-plane-3
[64.328854] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[65.417078] Starting dynamic subtest: pipe-B-plane-0
[65.846552] Dynamic subtest pipe-B-plane-0: SUCCESS (0.434s)
[65.854299] Starting dynamic subtest: pipe-B-plane-3
[66.103173] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[66.419575] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.837s)
[67.355711] [002/133] (956s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[67.682512] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[67.686740] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[67.987232] [003/133] (956s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[68.108689] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[68.113127] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[68.286991] [004/133] (955s left) prime_mmap_coherency (ioctl-errors)
[68.378223] Starting subtest: ioctl-errors
[83.755375] Subtest ioctl-errors: SUCCESS (15.350s)
[83.921249] [005/133] (940s left) perf (non-sampling-read-error)
[84.091112] Starting subtest: non-sampling-read-error
[84.102050] Subtest non-sampling-read-error: SUCCESS (0.011s)
[84.143630] [006/133] (940s left) core_getversion (basic)
[84.178587] Starting subtest: basic
[84.182206] Subtest basic: SUCCESS (0.000s)
[84.250355] [007/133] (939s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[84.361361] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[84.370675] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[84.458562] [008/133] (939s left) api_intel_allocator (execbuf-with-allocator)
[84.525068] Starting subtest: execbuf-with-allocator
[84.530691] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[84.682786] [009/133] (939s left) tools_test (sysfs_l3_parity)
[84.736992] Starting subtest: sysfs_l3_parity
[84.832857] Subtest sysfs_l3_parity: SKIP (0.104s)
[84.884598] [010/133] (939s left) kms_invalid_mode (bad-htotal)
[84.987444] Starting subtest: bad-htotal
[84.989277] Starting dynamic subtest: pipe-A-eDP-1
[85.273100] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[85.285869] Starting dynamic subtest: pipe-B-eDP-1
[85.288475] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[85.300215] Starting dynamic subtest: pipe-C-eDP-1
[85.302608] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[85.313616] Starting dynamic subtest: pipe-D-eDP-1
[85.315982] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[85.318424] Subtest bad-htotal: SUCCESS (0.289s)
[86.071120] [011/133] (938s left) kms_getfb (getfb2-handle-closed)
[86.163043] Starting subtest: getfb2-handle-closed
[86.165344] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[86.279508] [012/133] (938s left) gen3_mixed_blits
[86.395891] [013/133] (938s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[86.494924] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[93.868229] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.374s)
[94.002523] [014/133] (930s left) kms_cursor_crc (cursor-tearing-position-change)
[94.119617] Starting subtest: cursor-tearing-position-change
[94.121768] Starting dynamic subtest: pipe-A-eDP-1
[94.710551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.589s)
[94.720740] Starting dynamic subtest: pipe-D-eDP-1
[95.942232] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[95.944584] Subtest cursor-tearing-position-change: SUCCESS (1.821s)
[96.781678] [015/133] (927s left) kms_flip (absolute-wf_vblank)
[96.881413] Starting subtest: absolute-wf_vblank
[96.883851] Starting dynamic subtest: A-eDP1
[105.673265] Dynamic subtest A-eDP1: SUCCESS (8.754s)
[105.683222] Starting dynamic subtest: B-eDP1
[114.404042] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[114.412727] Starting dynamic subtest: C-eDP1
[123.138079] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[123.147611] Starting dynamic subtest: D-eDP1
[131.867523] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[131.869873] Subtest absolute-wf_vblank: SUCCESS (34.937s)
[133.042136] [016/133] (891s left) kms_pm_backlight (basic-brightness)
[133.149541] Starting subtest: basic-brightness
[133.199621] Starting dynamic subtest: eDP-1
[133.705616] Dynamic subtest eDP-1: SUCCESS (0.503s)
[133.707643] Subtest basic-brightness: SUCCESS (0.555s)
[134.550875] [017/133] (890s left) kms_color (ctm-max)
[134.650271] Starting subtest: ctm-max
[134.652377] Starting dynamic subtest: pipe-A-eDP-1
[135.365651] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[135.376080] Starting dynamic subtest: pipe-B-eDP-1
[136.788273] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.422s)
[136.797475] Starting dynamic subtest: pipe-C-eDP-1
[138.135843] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.347s)
[138.144746] Starting dynamic subtest: pipe-D-eDP-1
[139.475545] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[139.477880] Subtest ctm-max: SUCCESS (4.823s)
[140.292100] [018/133] (884s left) gem_exec_params (rel-constants-invalid)
[140.359270] Starting subtest: rel-constants-invalid
[140.361175] Subtest rel-constants-invalid: SUCCESS (0.000s)
[140.475277] [019/133] (884s left) gem_exec_schedule (noreorder-corked)
[140.666088] Starting subtest: noreorder-corked
[140.668435] Starting dynamic subtest: rcs0
[141.818290] Dynamic subtest rcs0: SUCCESS (1.153s)
[141.827118] Starting dynamic subtest: vcs0
[144.989452] Dynamic subtest vcs0: SUCCESS (3.114s)
[145.000146] Starting dynamic subtest: vcs1
[146.919039] Dynamic subtest vcs1: SUCCESS (1.982s)
[146.929341] Starting dynamic subtest: vecs0
[148.910965] Dynamic subtest vecs0: SUCCESS (1.990s)
[148.921830] Starting dynamic subtest: ccs0
[150.086080] Dynamic subtest ccs0: SUCCESS (1.174s)
[150.088684] Subtest noreorder-corked: SUCCESS (9.422s)
[150.279922] [020/133] (874s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[150.330141] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[150.389783] [021/133] (874s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[150.785769] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[151.584972] [022/133] (873s left) gem_exec_whisper (basic-contexts-priority-all)
[151.646286] Starting subtest: basic-contexts-priority-all
[173.877178] Subtest basic-contexts-priority-all: SUCCESS (22.228s)
[174.099883] [023/133] (850s left) gen9_exec_parse (allowed-all)
[174.161510] Subtest allowed-all: SKIP (0.000s)
[174.256559] [024/133] (850s left) perf_pmu (busy-accuracy-98)
[174.293302] Starting subtest: busy-accuracy-98
[174.295067] Starting dynamic subtest: rcs0
[177.385371] Dynamic subtest rcs0: SUCCESS (3.040s)
[177.395597] Starting dynamic subtest: bcs0
[180.435052] Dynamic subtest bcs0: SUCCESS (3.049s)
[180.445520] Starting dynamic subtest: vcs0
[183.475761] Dynamic subtest vcs0: SUCCESS (3.039s)
[183.485069] Starting dynamic subtest: vcs1
[186.468191] Dynamic subtest vcs1: SUCCESS (3.040s)
[186.482759] Starting dynamic subtest: vecs0
[189.556353] Dynamic subtest vecs0: SUCCESS (3.037s)
[189.565162] Starting dynamic subtest: ccs0
[192.607720] Dynamic subtest ccs0: SUCCESS (3.050s)
[192.609666] Subtest busy-accuracy-98: SUCCESS (18.266s)
[192.716826] [025/133] (832s left) gem_workarounds (suspend-resume-fd)
[192.794450] Starting subtest: suspend-resume-fd
[209.069980] Subtest suspend-resume-fd: SUCCESS (1.366s)
[209.222433] [026/133] (815s left) kms_psr (fbc-pr-sprite-plane-move)
[209.319708] Starting subtest: fbc-pr-sprite-plane-move
[209.324119] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[209.398544] [027/133] (815s left) syncobj_wait (invalid-wait-bad-flags)
[209.466963] Starting subtest: invalid-wait-bad-flags
[209.468972] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[209.577444] [028/133] (815s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[209.674208] Starting subtest: fbc-rgb565-draw-mmap-wc
[213.729443] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.019s)
[214.920946] [029/133] (810s left) kms_addfb_basic (unused-offsets)
[214.986386] Starting subtest: unused-offsets
[214.988642] Subtest unused-offsets: SUCCESS (0.000s)
[215.138058] [030/133] (809s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[215.195807] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[215.197732] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[215.319046] [031/133] (809s left) kms_psr (fbc-pr-cursor-plane-move)
[215.419252] Starting subtest: fbc-pr-cursor-plane-move
[215.423708] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[215.505378] [032/133] (809s left) kms_psr (psr-cursor-render)
[215.598699] Starting subtest: psr-cursor-render
[215.601016] Starting dynamic subtest: eDP-1
[217.301803] Dynamic subtest eDP-1: SUCCESS (1.694s)
[217.304235] Subtest psr-cursor-render: SUCCESS (1.695s)
[218.193650] [033/133] (807s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[218.300607] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[218.313188] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[218.406187] [034/133] (806s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[218.497192] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[218.501615] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[218.586567] [035/133] (806s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[218.692146] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[218.696501] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[218.778308] [036/133] (806s left) kms_addfb_basic (invalid-get-prop)
[218.846490] Starting subtest: invalid-get-prop
[218.849029] Subtest invalid-get-prop: SUCCESS (0.000s)
[219.021376] [037/133] (806s left) gem_softpin (evict-prime-sanity-check)
[219.086088] Starting subtest: evict-prime-sanity-check
[219.088467] Starting dynamic subtest: rcs0
[220.272325] Dynamic subtest rcs0: SUCCESS (1.181s)
[220.284863] Starting dynamic subtest: bcs0
[221.434621] Dynamic subtest bcs0: SUCCESS (1.152s)
[221.446819] Starting dynamic subtest: vcs0
[222.815503] Dynamic subtest vcs0: SUCCESS (1.379s)
[222.827374] Starting dynamic subtest: vcs1
[224.806610] Dynamic subtest vcs1: SUCCESS (1.984s)
[224.818671] Starting dynamic subtest: vecs0
[226.753204] Dynamic subtest vecs0: SUCCESS (1.941s)
[226.762953] Starting dynamic subtest: ccs0
[227.928299] Dynamic subtest ccs0: SUCCESS (1.172s)
[227.941486] Starting dynamic subtest: all
[229.076981] Dynamic subtest all: SUCCESS (1.145s)
[229.079699] Subtest evict-prime-sanity-check: SUCCESS (9.967s)
[229.167912] [038/133] (796s left) i915_suspend (fence-restore-untiled)
[229.218814] Starting subtest: fence-restore-untiled
[229.223305] Subtest fence-restore-untiled: SKIP (0.000s)
[229.340214] [039/133] (796s left) kms_psr (psr-sprite-mmap-gtt)
[229.442502] Starting subtest: psr-sprite-mmap-gtt
[229.444764] Starting dynamic subtest: eDP-1
[230.930680] Dynamic subtest eDP-1: SKIP (1.483s)
[230.936010] Subtest psr-sprite-mmap-gtt: SKIP (1.484s)
[231.125482] [040/133] (794s left) gem_userptr_blits (unsync-unmap)
[231.208187] Subtest unsync-unmap: SKIP (0.000s)
[231.347503] [041/133] (794s left) gem_exec_balancer (bonded-true-hang)
[231.596499] Starting subtest: bonded-true-hang
[231.601138] Subtest bonded-true-hang: SKIP (0.000s)
[231.707264] [042/133] (793s left) gem_lmem_swapping (parallel-random-engines)
[231.751465] Subtest parallel-random-engines: SKIP (0.000s)
[231.790558] [043/133] (793s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[231.858804] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[231.863188] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[232.049564] [044/133] (793s left) syncobj_timeline (etime-single-wait-all-submitted)
[232.112273] Starting subtest: etime-single-wait-all-submitted
[232.219384] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s)
[232.306735] [045/133] (793s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[232.400913] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[232.404940] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[232.520893] [046/133] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[232.613491] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[232.617788] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[232.723561] [047/133] (793s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[232.853500] Starting subtest: short-busy-flip-before-cursor-toggle
[232.858154] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[233.021023] [048/133] (792s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[233.111806] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[240.216571] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.103s)
[240.380602] [049/133] (785s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[240.483804] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[240.486150] Starting dynamic subtest: pipe-A-eDP-1
[240.509281] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[240.521173] Starting dynamic subtest: pipe-B-eDP-1
[240.542685] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[240.551903] Starting dynamic subtest: pipe-C-eDP-1
[240.573611] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[240.583421] Starting dynamic subtest: pipe-D-eDP-1
[240.606525] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[240.611069] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[242.723181] [050/133] (783s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[242.833513] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[242.835800] Starting dynamic subtest: pipe-A-eDP-1
[242.856598] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[242.869378] Starting dynamic subtest: pipe-B-eDP-1
[242.890112] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[242.905618] Starting dynamic subtest: pipe-C-eDP-1
[242.925944] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[242.935536] Starting dynamic subtest: pipe-D-eDP-1
[242.955113] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[242.957039] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[245.072564] [051/133] (780s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[245.173926] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[245.178201] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[245.308683] [052/133] (780s left) gem_partial_pwrite_pread (reads-snoop)
[245.371686] Subtest reads-snoop: SKIP (0.000s)
[245.443836] [053/133] (780s left) syncobj_timeline (invalid-query-illegal-handle)
[245.502044] Starting subtest: invalid-query-illegal-handle
[245.504355] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[245.613108] [054/133] (780s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[245.712477] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[252.782857] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.075s)
[252.983901] [055/133] (773s left) kms_lease (lease-unleased-connector)
[253.077200] Starting subtest: lease-unleased-connector
[253.079425] Starting dynamic subtest: pipe-A-eDP-1
[253.084477] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[253.094558] Starting dynamic subtest: pipe-B-eDP-1
[253.096749] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[253.107259] Starting dynamic subtest: pipe-C-eDP-1
[253.109425] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[253.119049] Starting dynamic subtest: pipe-D-eDP-1
[253.121169] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[253.123258] Subtest lease-unleased-connector: SUCCESS (0.034s)
[253.236820] [056/133] (772s left) syncobj_wait (invalid-single-wait-unsubmitted)
[253.296488] Starting subtest: invalid-single-wait-unsubmitted
[253.298780] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[253.427098] [057/133] (772s left) gem_mmap_gtt (ptrace)
[253.486126] Subtest ptrace: SKIP (0.000s)
[253.550622] [058/133] (772s left) syncobj_timeline (multi-wait-submitted-signaled)
[253.608921] Starting subtest: multi-wait-submitted-signaled
[253.611098] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[253.744103] [059/133] (772s left) gem_madvise (dontneed-before-exec)
[253.776124] Starting subtest: dontneed-before-exec
[253.800205] Subtest dontneed-before-exec: SKIP (0.023s)
[253.871459] [060/133] (772s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[253.965708] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[253.969071] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[254.075700] [061/133] (772s left) gem_ccs (ctrl-surf-copy-new-ctx)
[254.129954] Starting subtest: ctrl-surf-copy-new-ctx
[254.133981] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[254.255724] [062/133] (772s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[254.352281] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[258.806178] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.456s)
[260.005871] [063/133] (766s left) syncobj_wait (single-wait-all-for-submit-signaled)
[260.075165] Starting subtest: single-wait-all-for-submit-signaled
[260.077524] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[260.203935] [064/133] (766s left) gem_ctx_isolation (nonpriv-switch)
[260.271782] Starting subtest: nonpriv-switch
[260.274201] Starting dynamic subtest: rcs0
[260.559325] Dynamic subtest rcs0: SUCCESS (0.287s)
[260.571574] Starting dynamic subtest: bcs0
[260.888152] Dynamic subtest bcs0: SUCCESS (0.328s)
[260.899248] Starting dynamic subtest: vcs0
[261.178640] Dynamic subtest vcs0: SUCCESS (0.289s)
[261.189908] Starting dynamic subtest: vcs1
[263.105402] Dynamic subtest vcs1: SUCCESS (1.925s)
[263.117786] Starting dynamic subtest: vecs0
[265.152611] Dynamic subtest vecs0: SUCCESS (2.046s)
[265.164941] Starting dynamic subtest: ccs0
[267.176097] Dynamic subtest ccs0: SUCCESS (2.022s)
[267.178514] Subtest nonpriv-switch: SUCCESS (6.904s)
[267.451956] [065/133] (759s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[267.541391] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[267.545746] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[267.627841] [066/133] (758s left) i915_drm_fdinfo (most-busy-check-all)
[267.671422] Starting subtest: most-busy-check-all
[267.673817] Starting dynamic subtest: rcs0
[267.678275] Dynamic subtest rcs0: SKIP (0.004s)
[267.687999] Starting dynamic subtest: bcs0
[267.692079] Dynamic subtest bcs0: SKIP (0.000s)
[267.701248] Starting dynamic subtest: vcs0
[267.705739] Dynamic subtest vcs0: SKIP (0.000s)
[267.714512] Starting dynamic subtest: vcs1
[267.718612] Dynamic subtest vcs1: SKIP (0.000s)
[267.727401] Starting dynamic subtest: vecs0
[267.731572] Dynamic subtest vecs0: SKIP (0.000s)
[267.740383] Starting dynamic subtest: ccs0
[267.744513] Dynamic subtest ccs0: SKIP (0.000s)
[267.748592] Subtest most-busy-check-all: SKIP (0.009s)
[267.784634] [067/133] (758s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[267.914347] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[267.916648] Starting dynamic subtest: pipe-A-eDP-1
[267.998063] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[268.008084] Starting dynamic subtest: pipe-B-eDP-1
[269.145427] Dynamic subtest pipe-B-eDP-1: SKIP (1.145s)
[269.149965] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.236s)
[270.435646] [068/133] (756s left) gem_create (create-ext-placement-each)
[270.608545] Starting subtest: create-ext-placement-each
[270.611135] Subtest create-ext-placement-each: SUCCESS (0.000s)
[270.735877] [069/133] (755s left) gen7_exec_parse (basic-allocation)
[270.811578] Subtest basic-allocation: SKIP (0.000s)
[270.891685] [070/133] (755s left) api_intel_bb (intel-bb-blit-none)
[270.950757] Starting subtest: intel-bb-blit-none
[275.063302] Subtest intel-bb-blit-none: SUCCESS (4.112s)
[275.227098] [071/133] (751s left) kms_chamelium_hpd (vga-hpd)
[275.626779] Subtest vga-hpd: SKIP (0.000s)
[276.439898] [072/133] (750s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[276.501499] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[276.559637] [073/133] (750s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[276.627906] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[276.693409] [074/133] (750s left) i915_pm_rps (reset)
[276.755734] Starting subtest: reset
[285.217402] Subtest reset: SUCCESS (8.459s)
[285.369892] [075/133] (741s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[285.524824] Starting subtest: cursor-vs-flip-legacy
[314.899562] Subtest cursor-vs-flip-legacy: SUCCESS (29.369s)
[315.710119] [076/133] (711s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[315.809458] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[315.811680] Starting dynamic subtest: pipe-A-eDP-1
[315.820243] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[315.830514] Starting dynamic subtest: pipe-B-eDP-1
[315.839181] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[315.848787] Starting dynamic subtest: pipe-C-eDP-1
[315.857124] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[315.866261] Starting dynamic subtest: pipe-D-eDP-1
[315.874523] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[315.878589] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[318.071582] [077/133] (709s left) gem_exec_balancer (parallel-keep-in-fence)
[318.339728] Starting subtest: parallel-keep-in-fence
[319.532780] Subtest parallel-keep-in-fence: SUCCESS (1.193s)
[319.655194] [078/133] (707s left) prime_busy (after-wait)
[319.723487] Starting subtest: after-wait
[319.728121] Starting dynamic subtest: rcs0
[319.778492] Dynamic subtest rcs0: SUCCESS (0.053s)
[319.788903] Starting dynamic subtest: bcs0
[319.855407] Dynamic subtest bcs0: SUCCESS (0.076s)
[319.866200] Starting dynamic subtest: vcs0
[319.895239] Dynamic subtest vcs0: SUCCESS (0.039s)
[319.904762] Starting dynamic subtest: vcs1
[319.934992] Dynamic subtest vcs1: SUCCESS (0.039s)
[319.944503] Starting dynamic subtest: vecs0
[319.974831] Dynamic subtest vecs0: SUCCESS (0.039s)
[319.984526] Starting dynamic subtest: ccs0
[320.015210] Dynamic subtest ccs0: SUCCESS (0.040s)
[320.125004] Subtest after-wait: SUCCESS (0.400s)
[320.223815] [079/133] (706s left) gem_exec_schedule (u-independent)
[320.299920] Starting subtest: u-independent
[320.301977] Starting dynamic subtest: rcs0
[321.816833] Dynamic subtest rcs0: SUCCESS (1.526s)
[321.834305] Starting dynamic subtest: vcs0
[323.842094] Dynamic subtest vcs0: SUCCESS (2.023s)
[323.855163] Starting dynamic subtest: vcs1
[325.868625] Dynamic subtest vcs1: SUCCESS (2.024s)
[325.881717] Starting dynamic subtest: vecs0
[327.868683] Dynamic subtest vecs0: SUCCESS (1.999s)
[327.881876] Starting dynamic subtest: ccs0
[329.814870] Dynamic subtest ccs0: SUCCESS (1.943s)
[329.817740] Subtest u-independent: SUCCESS (9.526s)
[330.142518] [080/133] (697s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[330.248382] Starting subtest: fbc-pr-cursor-plane-update-sf
[330.252617] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[330.328360] [081/133] (696s left) kms_sequence (queue-busy)
[330.425487] Starting subtest: queue-busy
[330.427393] Starting dynamic subtest: pipe-A-eDP-1
[332.356396] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[332.367393] Starting dynamic subtest: pipe-B-eDP-1
[334.955885] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.597s)
[334.966941] Starting dynamic subtest: pipe-C-eDP-1
[337.564494] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.608s)
[337.575396] Starting dynamic subtest: pipe-D-eDP-1
[340.110552] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s)
[340.112898] Subtest queue-busy: SUCCESS (9.685s)
[340.927359] [082/133] (686s left) kms_chamelium_audio (hdmi-audio)
[341.313781] Subtest hdmi-audio: SKIP (0.000s)
[342.110568] [083/133] (685s left) gem_mmap_gtt (big-bo-tiledy)
[342.164143] Subtest big-bo-tiledY: SKIP (0.000s)
[342.229614] [084/133] (685s left) gem_mmap_wc (write-prefaulted)
[342.278647] Subtest write-prefaulted: SKIP (0.000s)
[342.347793] [085/133] (685s left) gem_exec_fence (syncobj-unused-fence)
[342.853542] Starting subtest: syncobj-unused-fence
[342.858267] Subtest syncobj-unused-fence: SUCCESS (0.006s)
[344.917919] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[344.921326] [086/133] (682s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[344.983731] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[345.091677] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.107s)
[345.183149] [087/133] (682s left) i915_hangman (engine-engine-hang)
[345.265241] Starting subtest: engine-engine-hang
[345.267255] Starting dynamic subtest: rcs0
[346.806718] Dynamic subtest rcs0: SUCCESS (1.541s)
[346.819703] Starting dynamic subtest: bcs0
[348.789504] Dynamic subtest bcs0: SUCCESS (1.980s)
[348.802115] Starting dynamic subtest: vcs0
[350.773867] Dynamic subtest vcs0: SUCCESS (1.981s)
[350.791970] Starting dynamic subtest: vcs1
[352.757772] Dynamic subtest vcs1: SUCCESS (1.981s)
[352.774622] Starting dynamic subtest: vecs0
[354.741680] Dynamic subtest vecs0: SUCCESS (1.981s)
[354.754821] Starting dynamic subtest: ccs0
[356.789842] Dynamic subtest ccs0: SUCCESS (2.045s)
[356.792747] Subtest engine-engine-hang: SUCCESS (11.525s)
[356.884512] [088/133] (670s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[356.997429] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[356.999712] Starting dynamic subtest: pipe-A-eDP-1
[357.059741] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[357.072000] Starting dynamic subtest: pipe-B-eDP-1
[357.127746] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[357.138575] Starting dynamic subtest: pipe-C-eDP-1
[357.194728] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[357.205585] Starting dynamic subtest: pipe-D-eDP-1
[357.261595] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[357.265801] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[359.224083] [089/133] (668s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[359.331513] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[359.335719] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[359.459176] [090/133] (668s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[359.559375] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[359.563725] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[359.648093] [091/133] (668s left) prime_mmap (test_map_unmap)
[359.711911] Starting subtest: test_map_unmap
[359.714080] Starting dynamic subtest: test_map_unmap-smem
[359.744821] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[359.747167] Subtest test_map_unmap: SUCCESS (0.034s)
[359.872432] [092/133] (667s left) prime_self_import (basic-with_two_bos)
[359.915648] Starting subtest: basic-with_two_bos
[359.929375] Subtest basic-with_two_bos: SUCCESS (0.019s)
[360.065585] [093/133] (667s left) sysfs_preempt_timeout (invalid)
[360.125279] Starting subtest: invalid
[360.127528] Starting dynamic subtest: vecs0
[360.129714] Dynamic subtest vecs0: SUCCESS (0.000s)
[360.140206] Starting dynamic subtest: ccs0
[360.141942] Dynamic subtest ccs0: SUCCESS (0.000s)
[360.151259] Starting dynamic subtest: vcs0
[360.153027] Dynamic subtest vcs0: SUCCESS (0.000s)
[360.162355] Starting dynamic subtest: bcs0
[360.164080] Dynamic subtest bcs0: SUCCESS (0.000s)
[360.173185] Starting dynamic subtest: rcs0
[360.174927] Dynamic subtest rcs0: SUCCESS (0.000s)
[360.184382] Starting dynamic subtest: vcs1
[360.185942] Dynamic subtest vcs1: SUCCESS (0.000s)
[360.187564] Subtest invalid: SUCCESS (0.006s)
[360.248827] [094/133] (667s left) kms_big_fb (linear-64bpp-rotate-180)
[360.358491] Starting subtest: linear-64bpp-rotate-180
[361.944520] Subtest linear-64bpp-rotate-180: SUCCESS (1.584s)
[362.127093] [095/133] (665s left) gem_tiled_pread_pwrite
[362.253570] [096/133] (665s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[362.350123] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[367.637314] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.289s)
[368.833543] [097/133] (659s left) gem_fence_thrash (bo-write-verify-y)
[368.873477] Starting subtest: bo-write-verify-y
[368.904997] Subtest bo-write-verify-y: SKIP (0.029s)
[368.975493] [098/133] (659s left) kms_big_fb (4-tiled-addfb)
[369.083894] Starting subtest: 4-tiled-addfb
[369.086122] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[369.193589] [099/133] (658s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[369.297724] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[373.761131] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.465s)
[374.934093] [100/133] (653s left) gem_exec_fence (syncobj-timeline-chain-engines)
[375.481888] Starting subtest: syncobj-timeline-chain-engines
[375.605545] Subtest syncobj-timeline-chain-engines: SUCCESS (0.124s)
[376.932274] [101/133] (651s left) kms_pm_rpm (modeset-non-lpsp)
[378.979991] Starting subtest: modeset-non-lpsp
[380.138547] Subtest modeset-non-lpsp: SKIP (1.159s)
[380.547227] [102/133] (647s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[380.639879] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[380.757393] [103/133] (647s left) kms_cursor_crc (cursor-size-hints)
[380.901096] Starting subtest: cursor-size-hints
[380.902932] Starting dynamic subtest: pipe-A-eDP-1
[381.517880] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.616s)
[381.528368] Starting dynamic subtest: pipe-D-eDP-1
[382.770143] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.252s)
[382.772516] Subtest cursor-size-hints: SUCCESS (1.871s)
[383.606622] [104/133] (644s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[383.727278] Starting subtest: yf-tiled-addfb-size-overflow
[383.731748] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[383.850294] [105/133] (644s left) gem_pxp (verify-pxp-stale-ctx-execution)
[383.969017] Starting subtest: verify-pxp-stale-ctx-execution
[385.025885] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.059s)
[385.169834] [106/133] (643s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[385.277889] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[386.290464] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.011s)
[386.405838] [107/133] (641s left) kms_psr (psr2-cursor-mmap-cpu)
[386.510841] Starting subtest: psr2-cursor-mmap-cpu
[386.512802] Starting dynamic subtest: eDP-1
[388.273516] Dynamic subtest eDP-1: SUCCESS (1.760s)
[388.275799] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.761s)
[389.082712] [108/133] (639s left) kms_psr (fbc-psr-sprite-plane-onoff)
[389.176600] Starting subtest: fbc-psr-sprite-plane-onoff
[389.178853] Starting dynamic subtest: eDP-1
[389.183150] Dynamic subtest eDP-1: SKIP (0.000s)
[389.187756] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[389.261634] [109/133] (639s left) kms_pm_rpm (fences-dpms)
[390.983377] Starting subtest: fences-dpms
[390.988279] Subtest fences-dpms: SKIP (0.000s)
[391.532945] [110/133] (636s left) prime_mmap_coherency (read)
[391.603660] Starting subtest: read
[397.032362] Subtest read: SUCCESS (5.376s)
[397.132370] [111/133] (631s left) gem_exec_fence (basic-busy-all)
[397.196517] Starting subtest: basic-busy-all
[397.300752] Subtest basic-busy-all: SUCCESS (0.104s)
[398.908322] [112/133] (629s left) prime_vgem (basic-fence-flip)
[398.995515] Starting subtest: basic-fence-flip
[399.288197] Subtest basic-fence-flip: SUCCESS (0.292s)
[399.406692] [113/133] (629s left) syncobj_wait (invalid-signal-bad-pad)
[399.472794] Starting subtest: invalid-signal-bad-pad
[399.475075] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[399.592267] [114/133] (629s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[399.680601] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[399.684530] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[399.790331] [115/133] (628s left) kms_big_fb (x-tiled-addfb)
[399.897612] Starting subtest: x-tiled-addfb
[399.899919] Subtest x-tiled-addfb: SUCCESS (0.000s)
[400.027097] [116/133] (628s left) gem_ctx_persistence (legacy-engines-hostile)
[400.096096] Starting subtest: legacy-engines-hostile
[400.098348] Starting dynamic subtest: render
[400.188521] Dynamic subtest render: SUCCESS (0.094s)
[400.201478] Starting dynamic subtest: bsd1
[400.296737] Dynamic subtest bsd1: SUCCESS (0.106s)
[400.311488] Starting dynamic subtest: bsd2
[400.411001] Dynamic subtest bsd2: SUCCESS (0.111s)
[400.425566] Starting dynamic subtest: blt
[400.526117] Dynamic subtest blt: SUCCESS (0.112s)
[400.541340] Starting dynamic subtest: vebox
[400.648094] Dynamic subtest vebox: SUCCESS (0.119s)
[400.650565] Subtest legacy-engines-hostile: SUCCESS (0.556s)
[400.738870] [117/133] (628s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[400.840326] Starting subtest: 4-tiled-16bpp-rotate-180
[402.077485] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.234s)
[402.246337] [118/133] (626s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[402.344950] Starting subtest: compare-crc-sanitycheck-nv12
[402.346944] Starting dynamic subtest: pipe-A-eDP-1
[403.038468] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.693s)
[403.050384] Starting dynamic subtest: pipe-B-eDP-1
[404.269216] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.228s)
[404.280418] Starting dynamic subtest: pipe-C-eDP-1
[405.469847] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.197s)
[405.481124] Starting dynamic subtest: pipe-D-eDP-1
[406.692314] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[406.694601] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.347s)
[407.542449] [119/133] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[407.665558] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[414.335732] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.672s)
[414.509094] [120/133] (614s left) kms_flip (wf_vblank-ts-check-interruptible)
[414.599779] Starting subtest: wf_vblank-ts-check-interruptible
[414.602107] Starting dynamic subtest: A-eDP1
[423.534501] Dynamic subtest A-eDP1: SUCCESS (8.898s)
[423.544957] Starting dynamic subtest: B-eDP1
[432.469089] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[432.480335] Starting dynamic subtest: C-eDP1
[441.408698] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[441.419452] Starting dynamic subtest: D-eDP1
[450.336757] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[450.338804] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.692s)
[451.531174] [121/133] (577s left) gem_eio (create)
[451.784057] Starting subtest: create
[452.131833] Subtest create: SUCCESS (0.347s)
[452.315280] [122/133] (576s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[452.478375] Starting subtest: dp-mst-lic-type-0-hdcp14
[452.482018] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[452.628777] [123/133] (576s left) kms_vblank (query-idle)
[452.724795] Starting subtest: query-idle
[452.726617] Starting dynamic subtest: pipe-A-eDP-1
[454.479619] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.754s)
[454.495190] Starting dynamic subtest: pipe-D-eDP-1
[456.960518] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.477s)
[456.962431] Subtest query-idle: SUCCESS (4.235s)
[457.804655] [124/133] (571s left) kms_plane_scaling (invalid-num-scalers)
[457.909230] Starting subtest: invalid-num-scalers
[457.911546] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[457.927242] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[457.937688] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[457.960894] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[457.971027] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[457.993976] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[458.004105] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[458.026532] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[458.028851] Subtest invalid-num-scalers: SUCCESS (0.118s)
[458.149115] [125/133] (571s left) kms_cursor_crc (cursor-onscreen-512x170)
[458.462557] Starting subtest: cursor-onscreen-512x170
[458.467079] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[458.645200] [126/133] (570s left) kms_rotation_crc (primary-rotation-270)
[458.744755] Starting subtest: primary-rotation-270
[458.748416] Subtest primary-rotation-270: SKIP (0.001s)
[458.828845] [127/133] (570s left) perf (invalid-oa-metric-set-id)
[458.929403] Starting subtest: invalid-oa-metric-set-id
[458.938675] Subtest invalid-oa-metric-set-id: SUCCESS (0.008s)
[458.982321] [128/133] (570s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[459.039124] Starting subtest: single-wait-all-for-submit-available-submitted
[459.040934] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[459.182765] [129/133] (570s left) kms_draw_crc (draw-method-render)
[459.280264] Starting subtest: draw-method-render
[459.281841] Starting dynamic subtest: xrgb8888-untiled
[459.524211] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[459.543607] Starting dynamic subtest: rgb565-untiled
[459.757018] Dynamic subtest rgb565-untiled: SUCCESS (0.230s)
[459.768160] Starting dynamic subtest: xrgb2101010-untiled
[459.968127] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[459.978199] Starting dynamic subtest: xbgr16161616f-untiled
[460.201679] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[460.214526] Starting dynamic subtest: xrgb8888-xtiled
[460.323632] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[460.333388] Starting dynamic subtest: rgb565-xtiled
[460.434685] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[460.444511] Starting dynamic subtest: xrgb2101010-xtiled
[460.557083] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[460.567341] Starting dynamic subtest: xbgr16161616f-xtiled
[460.690369] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[460.700339] Starting dynamic subtest: xrgb8888-4tiled
[460.823798] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[460.834401] Starting dynamic subtest: rgb565-4tiled
[460.946041] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[460.956653] Starting dynamic subtest: xrgb2101010-4tiled
[461.068261] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[461.078587] Starting dynamic subtest: xbgr16161616f-4tiled
[461.202184] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[461.204101] Subtest draw-method-render: SUCCESS (1.923s)
[461.345772] [130/133] (568s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[461.489724] Starting subtest: basic-flip-before-cursor-legacy
[462.418742] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.924s)
[463.226926] [131/133] (566s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[463.331505] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[463.335565] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[463.466285] [132/133] (565s left) perf_pmu (idle-no-semaphores)
[463.505017] Starting subtest: idle-no-semaphores
[463.507259] Starting dynamic subtest: rcs0
[464.065106] Dynamic subtest rcs0: SUCCESS (0.559s)
[464.078045] Starting dynamic subtest: bcs0
[464.587200] Dynamic subtest bcs0: SUCCESS (0.519s)
[464.600148] Starting dynamic subtest: vcs0
[465.112413] Dynamic subtest vcs0: SUCCESS (0.522s)
[465.125584] Starting dynamic subtest: vcs1
[465.630218] Dynamic subtest vcs1: SUCCESS (0.515s)
[465.642368] Starting dynamic subtest: vecs0
[466.151501] Dynamic subtest vecs0: SUCCESS (0.519s)
[466.164924] Starting dynamic subtest: ccs0
[466.669529] Dynamic subtest ccs0: SUCCESS (0.515s)
[466.672056] Subtest idle-no-semaphores: SUCCESS (3.166s)
[466.803916] [133/133] (562s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[466.867884] Starting subtest: multi-wait-all-for-submit-signaled
[466.870152] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[466.976478] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: prime_mmap_coherency
results: parsing output: 4/ for test: perf
results: parsing output: 5/ for test: core_getversion
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: api_intel_allocator
results: parsing output: 8/ for test: tools_test
results: parsing output: 9/ for test: kms_invalid_mode
results: parsing output: 10/ for test: kms_getfb
results: parsing output: 11/ for test: gen3_mixed_blits
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_pm_backlight
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_chamelium_frames
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: gem_workarounds
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: i915_suspend
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_partial_pwrite_pread
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_lease
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_madvise
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_ccs
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_ctx_isolation
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: gem_create
results: parsing output: 68/ for test: gen7_exec_parse
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: kms_pipe_b_c_ivb
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: i915_pm_rps
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: prime_busy
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_sequence
results: parsing output: 81/ for test: kms_chamelium_audio
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_plane
results: parsing output: 90/ for test: prime_mmap
results: parsing output: 91/ for test: prime_self_import
results: parsing output: 92/ for test: sysfs_preempt_timeout
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_tiled_pread_pwrite
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_fence_thrash
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_pm_rpm
results: parsing output: 109/ for test: prime_mmap_coherency
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: prime_vgem
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: kms_content_protection
results: parsing output: 122/ for test: kms_vblank
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_rotation_crc
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_draw_crc
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: perf_pmu
results: parsing output: 132/ for test: syncobj_wait
Done.