[57.223976] Initializing watchdogs
[57.224045]   /dev/watchdog0
[57.238389] [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]
[57.243063] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.245402] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.248747] [001/133] (960s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[57.378071] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[57.416566] Starting dynamic subtest: pipe-A-plane-0
[57.847603] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[57.855857] Starting dynamic subtest: pipe-A-plane-3
[58.113800] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[59.215887] Starting dynamic subtest: pipe-B-plane-0
[59.653678] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[59.662412] Starting dynamic subtest: pipe-B-plane-3
[59.920591] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[60.235718] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.858s)
[61.098715] [002/133] (956s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[61.209126] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[61.213285] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[61.308948] [003/133] (956s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[61.417744] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[61.421930] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[61.548770] [004/133] (956s left) prime_mmap_coherency (ioctl-errors)
[61.615382] Starting subtest: ioctl-errors
[77.385063] Subtest ioctl-errors: SUCCESS (15.772s)
[77.557436] [005/133] (940s left) perf (non-sampling-read-error)
[77.730044] Starting subtest: non-sampling-read-error
[77.742125] Subtest non-sampling-read-error: SUCCESS (0.011s)
[77.781632] [006/133] (940s left) core_getversion (basic)
[77.816463] Starting subtest: basic
[77.820506] Subtest basic: SUCCESS (0.000s)
[77.885724] [007/133] (940s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[77.985891] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[77.995494] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[78.117312] [008/133] (939s left) api_intel_allocator (execbuf-with-allocator)
[78.175282] Starting subtest: execbuf-with-allocator
[78.179310] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[78.354829] [009/133] (939s left) tools_test (sysfs_l3_parity)
[78.402369] Starting subtest: sysfs_l3_parity
[78.492331] Subtest sysfs_l3_parity: SKIP (0.100s)
[78.557317] [010/133] (939s left) kms_invalid_mode (bad-htotal)
[78.654024] Starting subtest: bad-htotal
[78.655933] Starting dynamic subtest: pipe-A-eDP-1
[78.955406] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.303s)
[78.965667] Starting dynamic subtest: pipe-B-eDP-1
[78.967767] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[78.975412] Starting dynamic subtest: pipe-C-eDP-1
[78.977598] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[78.985315] Starting dynamic subtest: pipe-D-eDP-1
[78.987258] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[78.989111] Subtest bad-htotal: SUCCESS (0.308s)
[79.848997] [011/133] (938s left) kms_getfb (getfb2-handle-closed)
[79.952054] Starting subtest: getfb2-handle-closed
[79.954337] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[80.108726] [012/133] (938s left) gen3_mixed_blits
[80.250387] [013/133] (937s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[80.352695] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[87.678894] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.328s)
[87.835690] [014/133] (930s left) kms_cursor_crc (cursor-tearing-position-change)
[87.968047] Starting subtest: cursor-tearing-position-change
[87.970213] Starting dynamic subtest: pipe-A-eDP-1
[88.556850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.585s)
[88.568376] Starting dynamic subtest: pipe-D-eDP-1
[89.773530] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.217s)
[89.775893] Subtest cursor-tearing-position-change: SUCCESS (1.804s)
[90.616689] [015/133] (927s left) kms_flip (absolute-wf_vblank)
[90.712297] Starting subtest: absolute-wf_vblank
[90.714443] Starting dynamic subtest: A-eDP1
[99.467782] Dynamic subtest A-eDP1: SUCCESS (8.754s)
[99.476175] Starting dynamic subtest: B-eDP1
[108.192647] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[108.202990] Starting dynamic subtest: C-eDP1
[116.910304] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[116.921089] Starting dynamic subtest: D-eDP1
[125.638259] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[125.643387] Subtest absolute-wf_vblank: SUCCESS (34.930s)
[126.859292] [016/133] (891s left) kms_pm_backlight (basic-brightness)
[126.963121] Starting subtest: basic-brightness
[127.013822] Starting dynamic subtest: eDP-1
[127.519719] Dynamic subtest eDP-1: SUCCESS (0.508s)
[127.522207] Subtest basic-brightness: SUCCESS (0.558s)
[128.382217] [017/133] (889s left) kms_color (ctm-max)
[128.480983] Starting subtest: ctm-max
[128.482891] Starting dynamic subtest: pipe-A-eDP-1
[129.192353] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[129.201844] Starting dynamic subtest: pipe-B-eDP-1
[130.597322] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.405s)
[130.606722] Starting dynamic subtest: pipe-C-eDP-1
[131.969069] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[131.978034] Starting dynamic subtest: pipe-D-eDP-1
[133.296756] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[133.299106] Subtest ctm-max: SUCCESS (4.817s)
[134.109914] [018/133] (884s left) gem_exec_params (rel-constants-invalid)
[134.176121] Starting subtest: rel-constants-invalid
[134.178560] Subtest rel-constants-invalid: SUCCESS (0.000s)
[134.305582] [019/133] (884s left) gem_exec_schedule (noreorder-corked)
[134.501836] Starting subtest: noreorder-corked
[134.504236] Starting dynamic subtest: rcs0
[135.658357] Dynamic subtest rcs0: SUCCESS (1.156s)
[135.668263] Starting dynamic subtest: vcs0
[136.946721] Dynamic subtest vcs0: SUCCESS (1.285s)
[136.958050] Starting dynamic subtest: vcs1
[138.914668] Dynamic subtest vcs1: SUCCESS (1.966s)
[138.926346] Starting dynamic subtest: vecs0
[140.902494] Dynamic subtest vecs0: SUCCESS (1.986s)
[140.913094] Starting dynamic subtest: ccs0
[142.053039] Dynamic subtest ccs0: SUCCESS (1.149s)
[142.055747] Subtest noreorder-corked: SUCCESS (7.552s)
[142.263040] [020/133] (876s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[142.322720] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[142.391528] [021/133] (876s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[142.790047] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[143.604880] [022/133] (874s left) gem_exec_whisper (basic-contexts-priority-all)
[143.682610] Starting subtest: basic-contexts-priority-all
[165.854503] Subtest basic-contexts-priority-all: SUCCESS (22.166s)
[166.057592] [023/133] (852s left) gen9_exec_parse (allowed-all)
[166.117713] Subtest allowed-all: SKIP (0.000s)
[166.185821] [024/133] (852s left) perf_pmu (busy-accuracy-98)
[166.231744] Starting subtest: busy-accuracy-98
[166.233720] Starting dynamic subtest: rcs0
[169.273202] Dynamic subtest rcs0: SUCCESS (3.042s)
[169.281901] Starting dynamic subtest: bcs0
[172.323505] Dynamic subtest bcs0: SUCCESS (3.048s)
[172.332854] Starting dynamic subtest: vcs0
[175.367600] Dynamic subtest vcs0: SUCCESS (3.042s)
[175.379497] Starting dynamic subtest: vcs1
[178.409622] Dynamic subtest vcs1: SUCCESS (3.040s)
[178.420687] Starting dynamic subtest: vecs0
[181.453284] Dynamic subtest vecs0: SUCCESS (3.042s)
[181.464666] Starting dynamic subtest: ccs0
[184.505914] Dynamic subtest ccs0: SUCCESS (3.050s)
[184.508395] Subtest busy-accuracy-98: SUCCESS (18.275s)
[184.644431] [025/133] (834s left) gem_workarounds (suspend-resume-fd)
[184.711214] Starting subtest: suspend-resume-fd
[200.749217] Subtest suspend-resume-fd: SUCCESS (1.291s)
[200.913831] [026/133] (817s left) kms_psr (fbc-pr-sprite-plane-move)
[201.036412] Starting subtest: fbc-pr-sprite-plane-move
[201.040832] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[201.122838] [027/133] (817s left) syncobj_wait (invalid-wait-bad-flags)
[201.186288] Starting subtest: invalid-wait-bad-flags
[201.188647] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[201.288654] [028/133] (817s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[201.388117] Starting subtest: fbc-rgb565-draw-mmap-wc
[205.454137] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.063s)
[206.650103] [029/133] (812s left) kms_addfb_basic (unused-offsets)
[206.714335] Starting subtest: unused-offsets
[206.716629] Subtest unused-offsets: SUCCESS (0.000s)
[206.886397] [030/133] (811s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[206.948752] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[206.951018] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[207.070060] [031/133] (811s left) kms_psr (fbc-pr-cursor-plane-move)
[207.158008] Starting subtest: fbc-pr-cursor-plane-move
[207.162276] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[207.237800] [032/133] (811s left) kms_psr (psr-cursor-render)
[207.324596] Starting subtest: psr-cursor-render
[207.327063] Starting dynamic subtest: eDP-1
[209.014740] Dynamic subtest eDP-1: SUCCESS (1.689s)
[209.017033] Subtest psr-cursor-render: SUCCESS (1.690s)
[209.906957] [033/133] (809s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[210.001484] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[210.013058] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[210.137645] [034/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[210.225417] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[210.229862] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[210.341037] [035/133] (808s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[210.434436] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[210.438818] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[210.518997] [036/133] (808s left) kms_addfb_basic (invalid-get-prop)
[210.574999] Starting subtest: invalid-get-prop
[210.576960] Subtest invalid-get-prop: SUCCESS (0.000s)
[210.740349] [037/133] (808s left) gem_softpin (evict-prime-sanity-check)
[210.802923] Starting subtest: evict-prime-sanity-check
[210.805182] Starting dynamic subtest: rcs0
[211.995720] Dynamic subtest rcs0: SUCCESS (1.191s)
[212.007148] Starting dynamic subtest: bcs0
[213.124721] Dynamic subtest bcs0: SUCCESS (1.126s)
[213.136922] Starting dynamic subtest: vcs0
[214.621943] Dynamic subtest vcs0: SUCCESS (1.493s)
[214.634543] Starting dynamic subtest: vcs1
[216.598065] Dynamic subtest vcs1: SUCCESS (1.973s)
[216.610257] Starting dynamic subtest: vecs0
[218.690540] Dynamic subtest vecs0: SUCCESS (2.090s)
[218.702977] Starting dynamic subtest: ccs0
[219.835981] Dynamic subtest ccs0: SUCCESS (1.145s)
[219.848532] Starting dynamic subtest: all
[220.973107] Dynamic subtest all: SUCCESS (1.135s)
[220.975931] Subtest evict-prime-sanity-check: SUCCESS (10.166s)
[221.066017] [038/133] (798s left) i915_suspend (fence-restore-untiled)
[221.123512] Starting subtest: fence-restore-untiled
[221.127902] Subtest fence-restore-untiled: SKIP (0.000s)
[221.247513] [039/133] (797s left) kms_psr (psr-sprite-mmap-gtt)
[221.342651] Starting subtest: psr-sprite-mmap-gtt
[221.344984] Starting dynamic subtest: eDP-1
[222.806733] Dynamic subtest eDP-1: SKIP (1.462s)
[222.811639] Subtest psr-sprite-mmap-gtt: SKIP (1.463s)
[222.992596] [040/133] (796s left) gem_userptr_blits (unsync-unmap)
[223.059383] Subtest unsync-unmap: SKIP (0.000s)
[223.208211] [041/133] (796s left) gem_exec_balancer (bonded-true-hang)
[223.468666] Starting subtest: bonded-true-hang
[223.474165] Subtest bonded-true-hang: SKIP (0.000s)
[223.592815] [042/133] (795s left) gem_lmem_swapping (parallel-random-engines)
[223.639109] Subtest parallel-random-engines: SKIP (0.000s)
[223.680061] [043/133] (795s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[223.732240] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[223.736605] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[223.929102] [044/133] (795s left) syncobj_timeline (etime-single-wait-all-submitted)
[223.987496] Starting subtest: etime-single-wait-all-submitted
[224.088891] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[224.176419] [045/133] (795s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[224.280500] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[224.284487] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[224.399530] [046/133] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[224.502068] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[224.506332] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[224.635870] [047/133] (794s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[224.756147] Starting subtest: short-busy-flip-before-cursor-toggle
[224.760650] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[224.913000] [048/133] (794s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[225.015941] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[232.107493] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.093s)
[232.255811] [049/133] (787s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[232.363650] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[232.365948] Starting dynamic subtest: pipe-A-eDP-1
[232.388083] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[232.397994] Starting dynamic subtest: pipe-B-eDP-1
[232.419419] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.428410] Starting dynamic subtest: pipe-C-eDP-1
[232.450621] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.466089] Starting dynamic subtest: pipe-D-eDP-1
[232.489938] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.494477] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[234.613451] [050/133] (785s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[234.722586] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[234.724783] Starting dynamic subtest: pipe-A-eDP-1
[234.744592] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[234.756670] Starting dynamic subtest: pipe-B-eDP-1
[234.776045] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[234.785514] Starting dynamic subtest: pipe-C-eDP-1
[234.805410] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[234.816867] Starting dynamic subtest: pipe-D-eDP-1
[234.836019] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[234.838218] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.009s)
[236.975748] [051/133] (782s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[237.073925] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[237.078096] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[237.186701] [052/133] (782s left) gem_partial_pwrite_pread (reads-snoop)
[237.259409] Subtest reads-snoop: SKIP (0.000s)
[237.346534] [053/133] (782s left) syncobj_timeline (invalid-query-illegal-handle)
[237.394148] Starting subtest: invalid-query-illegal-handle
[237.396336] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[237.512083] [054/133] (782s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[237.607958] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[244.662982] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.060s)
[244.824054] [055/133] (775s left) kms_lease (lease-unleased-connector)
[244.915016] Starting subtest: lease-unleased-connector
[244.917443] Starting dynamic subtest: pipe-A-eDP-1
[244.922599] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[244.933332] Starting dynamic subtest: pipe-B-eDP-1
[244.935567] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[244.945806] Starting dynamic subtest: pipe-C-eDP-1
[244.948032] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[244.958128] Starting dynamic subtest: pipe-D-eDP-1
[244.960316] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[244.962414] Subtest lease-unleased-connector: SUCCESS (0.040s)
[245.084253] [056/133] (774s left) syncobj_wait (invalid-single-wait-unsubmitted)
[245.140258] Starting subtest: invalid-single-wait-unsubmitted
[245.142520] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[245.242812] [057/133] (774s left) gem_mmap_gtt (ptrace)
[245.309517] Subtest ptrace: SKIP (0.000s)
[245.373109] [058/133] (774s left) syncobj_timeline (multi-wait-submitted-signaled)
[245.437266] Starting subtest: multi-wait-submitted-signaled
[245.439432] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[245.570648] [059/133] (774s left) gem_madvise (dontneed-before-exec)
[245.604615] Starting subtest: dontneed-before-exec
[245.636699] Subtest dontneed-before-exec: SKIP (0.032s)
[245.705730] [060/133] (774s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[245.806657] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[245.810065] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[245.952037] [061/133] (774s left) gem_ccs (ctrl-surf-copy-new-ctx)
[246.021756] Starting subtest: ctrl-surf-copy-new-ctx
[246.025341] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[246.149209] [062/133] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[246.244866] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[250.670736] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.428s)
[251.820857] [063/133] (768s left) syncobj_wait (single-wait-all-for-submit-signaled)
[251.876420] Starting subtest: single-wait-all-for-submit-signaled
[251.878336] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[252.024675] [064/133] (768s left) gem_ctx_isolation (nonpriv-switch)
[252.096207] Starting subtest: nonpriv-switch
[252.098618] Starting dynamic subtest: rcs0
[252.381383] Dynamic subtest rcs0: SUCCESS (0.285s)
[252.391461] Starting dynamic subtest: bcs0
[252.677188] Dynamic subtest bcs0: SUCCESS (0.295s)
[252.688487] Starting dynamic subtest: vcs0
[252.993170] Dynamic subtest vcs0: SUCCESS (0.315s)
[253.004494] Starting dynamic subtest: vcs1
[254.959417] Dynamic subtest vcs1: SUCCESS (1.965s)
[254.970731] Starting dynamic subtest: vecs0
[256.929858] Dynamic subtest vecs0: SUCCESS (1.970s)
[256.939385] Starting dynamic subtest: ccs0
[259.037518] Dynamic subtest ccs0: SUCCESS (2.107s)
[259.039950] Subtest nonpriv-switch: SUCCESS (6.942s)
[259.314101] [065/133] (760s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[259.409669] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[259.413994] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[259.493856] [066/133] (760s left) i915_drm_fdinfo (most-busy-check-all)
[259.533433] Starting subtest: most-busy-check-all
[259.535876] Starting dynamic subtest: rcs0
[259.540510] Dynamic subtest rcs0: SKIP (0.003s)
[259.552561] Starting dynamic subtest: bcs0
[259.556791] Dynamic subtest bcs0: SKIP (0.000s)
[259.566230] Starting dynamic subtest: vcs0
[259.570624] Dynamic subtest vcs0: SKIP (0.000s)
[259.580091] Starting dynamic subtest: vcs1
[259.584448] Dynamic subtest vcs1: SKIP (0.000s)
[259.593770] Starting dynamic subtest: vecs0
[259.598069] Dynamic subtest vecs0: SKIP (0.000s)
[259.607234] Starting dynamic subtest: ccs0
[259.611540] Dynamic subtest ccs0: SKIP (0.000s)
[259.615822] Subtest most-busy-check-all: SKIP (0.008s)
[259.651444] [067/133] (760s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[259.767479] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[259.769790] Starting dynamic subtest: pipe-A-eDP-1
[259.865410] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[259.876082] Starting dynamic subtest: pipe-B-eDP-1
[260.979070] Dynamic subtest pipe-B-eDP-1: SKIP (1.112s)
[260.984413] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.215s)
[262.178774] [068/133] (758s left) gem_create (create-ext-placement-each)
[262.365577] Starting subtest: create-ext-placement-each
[262.368155] Subtest create-ext-placement-each: SUCCESS (0.000s)
[262.484799] [069/133] (757s left) gen7_exec_parse (basic-allocation)
[262.544423] Subtest basic-allocation: SKIP (0.000s)
[262.629858] [070/133] (757s left) api_intel_bb (intel-bb-blit-none)
[262.690209] Starting subtest: intel-bb-blit-none
[266.498029] Subtest intel-bb-blit-none: SUCCESS (3.808s)
[266.631346] [071/133] (753s left) kms_chamelium_hpd (vga-hpd)
[267.019952] Subtest vga-hpd: SKIP (0.000s)
[267.879814] [072/133] (752s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[267.944939] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[268.002050] [073/133] (752s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[268.061541] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[268.137611] [074/133] (752s left) i915_pm_rps (reset)
[268.199636] Starting subtest: reset
[276.660458] Subtest reset: SUCCESS (8.460s)
[276.821809] [075/133] (743s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[276.960341] Starting subtest: cursor-vs-flip-legacy
[306.290920] Subtest cursor-vs-flip-legacy: SUCCESS (29.328s)
[307.138356] [076/133] (713s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[307.243762] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[307.246069] Starting dynamic subtest: pipe-A-eDP-1
[307.255189] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[307.276183] Starting dynamic subtest: pipe-B-eDP-1
[307.285534] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[307.306522] Starting dynamic subtest: pipe-C-eDP-1
[307.316016] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[307.328343] Starting dynamic subtest: pipe-D-eDP-1
[307.337728] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[307.342292] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[309.490121] [077/133] (711s left) gem_exec_balancer (parallel-keep-in-fence)
[309.730444] Starting subtest: parallel-keep-in-fence
[310.952022] Subtest parallel-keep-in-fence: SUCCESS (1.221s)
[311.072076] [078/133] (709s left) prime_busy (after-wait)
[311.138507] Starting subtest: after-wait
[311.140943] Starting dynamic subtest: rcs0
[311.183519] Dynamic subtest rcs0: SUCCESS (0.045s)
[311.194464] Starting dynamic subtest: bcs0
[311.250220] Dynamic subtest bcs0: SUCCESS (0.066s)
[311.261276] Starting dynamic subtest: vcs0
[311.291203] Dynamic subtest vcs0: SUCCESS (0.040s)
[311.300970] Starting dynamic subtest: vcs1
[311.332038] Dynamic subtest vcs1: SUCCESS (0.040s)
[311.341779] Starting dynamic subtest: vecs0
[311.372320] Dynamic subtest vecs0: SUCCESS (0.040s)
[311.382053] Starting dynamic subtest: ccs0
[311.412275] Dynamic subtest ccs0: SUCCESS (0.039s)
[311.521381] Subtest after-wait: SUCCESS (0.384s)
[311.604814] [079/133] (709s left) gem_exec_schedule (u-independent)
[311.684332] Starting subtest: u-independent
[311.686202] Starting dynamic subtest: rcs0
[313.646359] Dynamic subtest rcs0: SUCCESS (1.968s)
[313.659103] Starting dynamic subtest: vcs0
[315.668494] Dynamic subtest vcs0: SUCCESS (2.019s)
[315.681447] Starting dynamic subtest: vcs1
[317.725539] Dynamic subtest vcs1: SUCCESS (2.054s)
[317.743463] Starting dynamic subtest: vecs0
[319.702323] Dynamic subtest vecs0: SUCCESS (1.975s)
[319.714684] Starting dynamic subtest: ccs0
[321.646335] Dynamic subtest ccs0: SUCCESS (1.941s)
[321.648908] Subtest u-independent: SUCCESS (9.969s)
[321.948684] [080/133] (698s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[322.048806] Starting subtest: fbc-pr-cursor-plane-update-sf
[322.052821] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[322.127296] [081/133] (698s left) kms_sequence (queue-busy)
[322.219778] Starting subtest: queue-busy
[322.222140] Starting dynamic subtest: pipe-A-eDP-1
[324.158507] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[324.168597] Starting dynamic subtest: pipe-B-eDP-1
[326.778779] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.621s)
[326.789363] Starting dynamic subtest: pipe-C-eDP-1
[329.384973] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.603s)
[329.395217] Starting dynamic subtest: pipe-D-eDP-1
[331.998852] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.610s)
[332.001076] Subtest queue-busy: SUCCESS (9.778s)
[332.807451] [082/133] (688s left) kms_chamelium_audio (hdmi-audio)
[333.193338] Subtest hdmi-audio: SKIP (0.000s)
[334.016268] [083/133] (686s left) gem_mmap_gtt (big-bo-tiledy)
[334.082577] Subtest big-bo-tiledY: SKIP (0.000s)
[334.152482] [084/133] (686s left) gem_mmap_wc (write-prefaulted)
[334.225642] Subtest write-prefaulted: SKIP (0.000s)
[334.281420] [085/133] (686s left) gem_exec_fence (syncobj-unused-fence)
[334.785679] Starting subtest: syncobj-unused-fence
[334.791385] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[336.740954] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[336.744174] [086/133] (684s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[336.818187] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[336.921987] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s)
[337.023861] [087/133] (684s left) i915_hangman (engine-engine-hang)
[337.114350] Starting subtest: engine-engine-hang
[337.116597] Starting dynamic subtest: rcs0
[338.574070] Dynamic subtest rcs0: SUCCESS (1.457s)
[338.587536] Starting dynamic subtest: bcs0
[340.621339] Dynamic subtest bcs0: SUCCESS (2.044s)
[340.635060] Starting dynamic subtest: vcs0
[342.603934] Dynamic subtest vcs0: SUCCESS (1.980s)
[342.617544] Starting dynamic subtest: vcs1
[344.590865] Dynamic subtest vcs1: SUCCESS (1.984s)
[344.615371] Starting dynamic subtest: vecs0
[346.572913] Dynamic subtest vecs0: SUCCESS (1.980s)
[346.586717] Starting dynamic subtest: ccs0
[348.621381] Dynamic subtest ccs0: SUCCESS (2.045s)
[348.624156] Subtest engine-engine-hang: SUCCESS (11.506s)
[348.719472] [088/133] (672s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[348.832731] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[348.835003] Starting dynamic subtest: pipe-A-eDP-1
[348.893771] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[348.903821] Starting dynamic subtest: pipe-B-eDP-1
[348.960269] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[348.971988] Starting dynamic subtest: pipe-C-eDP-1
[349.028069] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s)
[349.038436] Starting dynamic subtest: pipe-D-eDP-1
[349.095198] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s)
[349.099529] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.016s)
[351.020887] [089/133] (670s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[351.121073] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[351.125444] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[351.256110] [090/133] (670s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[351.360885] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[351.365274] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[351.444609] [091/133] (669s left) prime_mmap (test_map_unmap)
[351.512596] Starting subtest: test_map_unmap
[351.515044] Starting dynamic subtest: test_map_unmap-smem
[351.543005] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[351.545403] Subtest test_map_unmap: SUCCESS (0.032s)
[351.687056] [092/133] (669s left) prime_self_import (basic-with_two_bos)
[351.729792] Starting subtest: basic-with_two_bos
[351.748602] Subtest basic-with_two_bos: SUCCESS (0.019s)
[351.867786] [093/133] (669s left) sysfs_preempt_timeout (invalid)
[351.925995] Starting subtest: invalid
[351.928396] Starting dynamic subtest: vecs0
[351.930663] Dynamic subtest vecs0: SUCCESS (0.000s)
[351.941754] Starting dynamic subtest: ccs0
[351.943433] Dynamic subtest ccs0: SUCCESS (0.000s)
[351.952330] Starting dynamic subtest: vcs0
[351.954011] Dynamic subtest vcs0: SUCCESS (0.000s)
[351.963195] Starting dynamic subtest: bcs0
[351.964937] Dynamic subtest bcs0: SUCCESS (0.000s)
[351.973851] Starting dynamic subtest: rcs0
[351.975357] Dynamic subtest rcs0: SUCCESS (0.000s)
[351.984565] Starting dynamic subtest: vcs1
[351.986399] Dynamic subtest vcs1: SUCCESS (0.000s)
[351.988175] Subtest invalid: SUCCESS (0.006s)
[352.048783] [094/133] (669s left) kms_big_fb (linear-64bpp-rotate-180)
[352.159378] Starting subtest: linear-64bpp-rotate-180
[353.784499] Subtest linear-64bpp-rotate-180: SUCCESS (1.624s)
[354.010583] [095/133] (667s left) gem_tiled_pread_pwrite
[354.158737] [096/133] (667s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[354.275397] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[359.542341] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.270s)
[360.747911] [097/133] (660s left) gem_fence_thrash (bo-write-verify-y)
[360.792763] Starting subtest: bo-write-verify-y
[360.816746] Subtest bo-write-verify-y: SKIP (0.020s)
[360.879741] [098/133] (660s left) kms_big_fb (4-tiled-addfb)
[360.980905] Starting subtest: 4-tiled-addfb
[360.982803] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[361.104127] [099/133] (660s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[361.219161] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[365.676667] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.461s)
[366.847979] [100/133] (654s left) gem_exec_fence (syncobj-timeline-chain-engines)
[367.399761] Starting subtest: syncobj-timeline-chain-engines
[367.509633] Subtest syncobj-timeline-chain-engines: SUCCESS (0.112s)
[368.715790] [101/133] (653s left) kms_pm_rpm (modeset-non-lpsp)
[370.768307] Starting subtest: modeset-non-lpsp
[371.936488] Subtest modeset-non-lpsp: SKIP (1.168s)
[372.331526] [102/133] (649s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[372.436021] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[372.569024] [103/133] (649s left) kms_cursor_crc (cursor-size-hints)
[372.703292] Starting subtest: cursor-size-hints
[372.705632] Starting dynamic subtest: pipe-A-eDP-1
[373.312957] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[373.323513] Starting dynamic subtest: pipe-D-eDP-1
[374.582074] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.269s)
[374.584401] Subtest cursor-size-hints: SUCCESS (1.879s)
[375.397769] [104/133] (646s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[375.514007] Starting subtest: yf-tiled-addfb-size-overflow
[375.518226] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[375.652730] [105/133] (646s left) gem_pxp (verify-pxp-stale-ctx-execution)
[375.808728] Starting subtest: verify-pxp-stale-ctx-execution
[376.874489] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.065s)
[377.037104] [106/133] (644s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[377.137378] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[378.215238] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.078s)
[378.388318] [107/133] (643s left) kms_psr (psr2-cursor-mmap-cpu)
[378.491218] Starting subtest: psr2-cursor-mmap-cpu
[378.493039] Starting dynamic subtest: eDP-1
[380.162447] Dynamic subtest eDP-1: SUCCESS (1.669s)
[380.164835] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.671s)
[380.965453] [108/133] (641s left) kms_psr (fbc-psr-sprite-plane-onoff)
[381.075317] Starting subtest: fbc-psr-sprite-plane-onoff
[381.077625] Starting dynamic subtest: eDP-1
[381.082015] Dynamic subtest eDP-1: SKIP (0.000s)
[381.086035] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.002s)
[381.178957] [109/133] (640s left) kms_pm_rpm (fences-dpms)
[382.807541] Starting subtest: fences-dpms
[382.813093] Subtest fences-dpms: SKIP (0.000s)
[383.434236] [110/133] (638s left) prime_mmap_coherency (read)
[383.497552] Starting subtest: read
[388.874192] Subtest read: SUCCESS (5.376s)
[389.028194] [111/133] (633s left) gem_exec_fence (basic-busy-all)
[389.089907] Starting subtest: basic-busy-all
[389.196170] Subtest basic-busy-all: SUCCESS (0.106s)
[390.772679] [112/133] (631s left) prime_vgem (basic-fence-flip)
[390.865834] Starting subtest: basic-fence-flip
[391.156730] Subtest basic-fence-flip: SUCCESS (0.291s)
[391.273655] [113/133] (631s left) syncobj_wait (invalid-signal-bad-pad)
[391.335356] Starting subtest: invalid-signal-bad-pad
[391.337701] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[391.459661] [114/133] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[391.551028] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[391.555273] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[391.686961] [115/133] (630s left) kms_big_fb (x-tiled-addfb)
[391.783239] Starting subtest: x-tiled-addfb
[391.785483] Subtest x-tiled-addfb: SUCCESS (0.000s)
[391.911251] [116/133] (630s left) gem_ctx_persistence (legacy-engines-hostile)
[391.982033] Starting subtest: legacy-engines-hostile
[391.984248] Starting dynamic subtest: render
[392.109479] Dynamic subtest render: SUCCESS (0.127s)
[392.123799] Starting dynamic subtest: bsd1
[392.229326] Dynamic subtest bsd1: SUCCESS (0.116s)
[392.244257] Starting dynamic subtest: bsd2
[392.347510] Dynamic subtest bsd2: SUCCESS (0.115s)
[392.360313] Starting dynamic subtest: blt
[392.433755] Dynamic subtest blt: SUCCESS (0.084s)
[392.449443] Starting dynamic subtest: vebox
[392.551286] Dynamic subtest vebox: SUCCESS (0.114s)
[392.553499] Subtest legacy-engines-hostile: SUCCESS (0.570s)
[392.650264] [117/133] (629s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[392.759778] Starting subtest: 4-tiled-16bpp-rotate-180
[394.117329] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.356s)
[394.263425] [118/133] (628s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[394.359385] Starting subtest: compare-crc-sanitycheck-nv12
[394.361373] Starting dynamic subtest: pipe-A-eDP-1
[395.048260] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[395.058762] Starting dynamic subtest: pipe-B-eDP-1
[396.356489] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.309s)
[396.367594] Starting dynamic subtest: pipe-C-eDP-1
[397.601215] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.241s)
[397.612754] Starting dynamic subtest: pipe-D-eDP-1
[398.798264] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.195s)
[398.800459] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.438s)
[399.664367] [119/133] (622s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[399.759526] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[406.449201] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.691s)
[406.623570] [120/133] (615s left) kms_flip (wf_vblank-ts-check-interruptible)
[406.715479] Starting subtest: wf_vblank-ts-check-interruptible
[406.717768] Starting dynamic subtest: A-eDP1
[415.613164] Dynamic subtest A-eDP1: SUCCESS (8.895s)
[415.625504] Starting dynamic subtest: B-eDP1
[424.546546] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[424.561544] Starting dynamic subtest: C-eDP1
[433.469110] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[433.480816] Starting dynamic subtest: D-eDP1
[442.320674] Dynamic subtest D-eDP1: SUCCESS (8.851s)
[442.325879] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.608s)
[443.570053] [121/133] (579s left) gem_eio (create)
[443.868753] Starting subtest: create
[444.219130] Subtest create: SUCCESS (0.348s)
[444.389908] [122/133] (578s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[444.536873] Starting subtest: dp-mst-lic-type-0-hdcp14
[444.540646] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[444.697657] [123/133] (578s left) kms_vblank (query-idle)
[444.787620] Starting subtest: query-idle
[444.789593] Starting dynamic subtest: pipe-A-eDP-1
[446.532738] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.742s)
[446.548740] Starting dynamic subtest: pipe-D-eDP-1
[448.973770] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.440s)
[448.976350] Subtest query-idle: SUCCESS (4.185s)
[449.819816] [124/133] (572s left) kms_plane_scaling (invalid-num-scalers)
[449.922975] Starting subtest: invalid-num-scalers
[449.925243] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[449.944653] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[449.955593] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[449.977775] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[449.988311] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[450.010054] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[450.020471] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[450.042924] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[450.045199] Subtest invalid-num-scalers: SUCCESS (0.118s)
[450.174265] [125/133] (572s left) kms_cursor_crc (cursor-onscreen-512x170)
[450.467598] Starting subtest: cursor-onscreen-512x170
[450.471984] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[450.637217] [126/133] (572s left) kms_rotation_crc (primary-rotation-270)
[450.738939] Starting subtest: primary-rotation-270
[450.742657] Subtest primary-rotation-270: SKIP (0.001s)
[450.835672] [127/133] (572s left) perf (invalid-oa-metric-set-id)
[450.948420] Starting subtest: invalid-oa-metric-set-id
[450.958527] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[451.001142] [128/133] (571s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[451.067950] Starting subtest: single-wait-all-for-submit-available-submitted
[451.070019] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[451.178501] [129/133] (571s left) kms_draw_crc (draw-method-render)
[451.267203] Starting subtest: draw-method-render
[451.268816] Starting dynamic subtest: xrgb8888-untiled
[451.498901] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[451.509380] Starting dynamic subtest: rgb565-untiled
[451.710048] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[451.720342] Starting dynamic subtest: xrgb2101010-untiled
[451.943476] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[451.953722] Starting dynamic subtest: xbgr16161616f-untiled
[452.187744] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[452.198272] Starting dynamic subtest: xrgb8888-xtiled
[452.310067] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[452.320519] Starting dynamic subtest: rgb565-xtiled
[452.421241] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[452.431761] Starting dynamic subtest: xrgb2101010-xtiled
[452.543465] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[452.553892] Starting dynamic subtest: xbgr16161616f-xtiled
[452.677184] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[452.687479] Starting dynamic subtest: xrgb8888-4tiled
[452.798893] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.120s)
[452.809244] Starting dynamic subtest: rgb565-4tiled
[452.910102] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[452.920521] Starting dynamic subtest: xrgb2101010-4tiled
[453.021398] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[453.031505] Starting dynamic subtest: xbgr16161616f-4tiled
[453.154547] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[453.156536] Subtest draw-method-render: SUCCESS (1.889s)
[453.306329] [130/133] (569s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[453.430020] Starting subtest: basic-flip-before-cursor-legacy
[454.347052] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.913s)
[455.156647] [131/133] (567s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[455.257150] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[455.261270] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[455.358913] [132/133] (567s left) perf_pmu (idle-no-semaphores)
[455.398166] Starting subtest: idle-no-semaphores
[455.400066] Starting dynamic subtest: rcs0
[455.960031] Dynamic subtest rcs0: SUCCESS (0.561s)
[455.973517] Starting dynamic subtest: bcs0
[456.478293] Dynamic subtest bcs0: SUCCESS (0.515s)
[456.491729] Starting dynamic subtest: vcs0
[456.999713] Dynamic subtest vcs0: SUCCESS (0.518s)
[457.013301] Starting dynamic subtest: vcs1
[457.525334] Dynamic subtest vcs1: SUCCESS (0.523s)
[457.538135] Starting dynamic subtest: vecs0
[458.044767] Dynamic subtest vecs0: SUCCESS (0.517s)
[458.058544] Starting dynamic subtest: ccs0
[458.567550] Dynamic subtest ccs0: SUCCESS (0.520s)
[458.570460] Subtest idle-no-semaphores: SUCCESS (3.170s)
[458.716534] [133/133] (564s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[458.779287] Starting subtest: multi-wait-all-for-submit-signaled
[458.781622] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[458.895495] 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.