[57.210242] Initializing watchdogs
[57.210293]   /dev/watchdog0
[57.225311] [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.229865] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.232265] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.235608] [001/133] (960s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[57.358946] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[57.397669] Starting dynamic subtest: pipe-A-plane-0
[57.834058] Dynamic subtest pipe-A-plane-0: SUCCESS (0.434s)
[57.842867] Starting dynamic subtest: pipe-A-plane-3
[58.091364] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[59.204932] Starting dynamic subtest: pipe-B-plane-0
[59.646174] Dynamic subtest pipe-B-plane-0: SUCCESS (0.445s)
[59.658396] Starting dynamic subtest: pipe-B-plane-3
[59.902674] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[60.215859] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.838s)
[61.094944] [002/133] (956s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[61.204415] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[61.208894] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[61.322223] [003/133] (956s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[61.431172] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[61.435567] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[61.562800] [004/133] (956s left) prime_mmap_coherency (ioctl-errors)
[61.645871] Starting subtest: ioctl-errors
[77.138535] Subtest ioctl-errors: SUCCESS (15.468s)
[77.406997] [005/133] (940s left) perf (non-sampling-read-error)
[77.600878] Starting subtest: non-sampling-read-error
[77.612831] Subtest non-sampling-read-error: SUCCESS (0.011s)
[77.655271] [006/133] (940s left) core_getversion (basic)
[77.696413] Starting subtest: basic
[77.700784] Subtest basic: SUCCESS (0.000s)
[77.769127] [007/133] (940s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[77.874491] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[77.886990] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.014s)
[77.976502] [008/133] (940s left) api_intel_allocator (execbuf-with-allocator)
[78.035749] Starting subtest: execbuf-with-allocator
[78.039937] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[78.169118] [009/133] (939s left) tools_test (sysfs_l3_parity)
[78.215318] Starting subtest: sysfs_l3_parity
[78.305993] Subtest sysfs_l3_parity: SKIP (0.101s)
[78.383629] [010/133] (939s left) kms_invalid_mode (bad-htotal)
[78.486232] Starting subtest: bad-htotal
[78.488270] Starting dynamic subtest: pipe-A-eDP-1
[78.779537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[78.788568] Starting dynamic subtest: pipe-B-eDP-1
[78.790631] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[78.798131] Starting dynamic subtest: pipe-C-eDP-1
[78.800073] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[78.808063] Starting dynamic subtest: pipe-D-eDP-1
[78.810386] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[78.812715] Subtest bad-htotal: SUCCESS (0.300s)
[79.659375] [011/133] (938s left) kms_getfb (getfb2-handle-closed)
[79.748437] Starting subtest: getfb2-handle-closed
[79.750479] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[79.896866] [012/133] (938s left) gen3_mixed_blits
[80.010969] [013/133] (938s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[80.121395] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[87.650172] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.530s)
[87.800604] [014/133] (930s left) kms_cursor_crc (cursor-tearing-position-change)
[87.933085] Starting subtest: cursor-tearing-position-change
[87.935375] Starting dynamic subtest: pipe-A-eDP-1
[88.519513] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[88.529233] Starting dynamic subtest: pipe-D-eDP-1
[89.709706] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.187s)
[89.712030] Subtest cursor-tearing-position-change: SUCCESS (1.776s)
[90.594394] [015/133] (927s left) kms_flip (absolute-wf_vblank)
[90.696418] Starting subtest: absolute-wf_vblank
[90.698797] Starting dynamic subtest: A-eDP1
[99.405857] Dynamic subtest A-eDP1: SUCCESS (8.709s)
[99.420796] Starting dynamic subtest: B-eDP1
[108.179041] Dynamic subtest B-eDP1: SUCCESS (8.736s)
[108.187134] Starting dynamic subtest: C-eDP1
[116.897458] Dynamic subtest C-eDP1: SUCCESS (8.706s)
[116.907397] Starting dynamic subtest: D-eDP1
[125.623300] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[125.625697] Subtest absolute-wf_vblank: SUCCESS (34.880s)
[126.804287] [016/133] (891s left) kms_pm_backlight (basic-brightness)
[126.909066] Starting subtest: basic-brightness
[126.959205] Starting dynamic subtest: eDP-1
[127.468850] Dynamic subtest eDP-1: SUCCESS (0.509s)
[127.471099] Subtest basic-brightness: SUCCESS (0.562s)
[128.322752] [017/133] (890s left) kms_color (ctm-max)
[128.416785] Starting subtest: ctm-max
[128.419063] Starting dynamic subtest: pipe-A-eDP-1
[129.133528] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.717s)
[129.142611] Starting dynamic subtest: pipe-B-eDP-1
[130.538021] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.403s)
[130.546974] Starting dynamic subtest: pipe-C-eDP-1
[131.889880] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.352s)
[131.898881] Starting dynamic subtest: pipe-D-eDP-1
[133.213187] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[133.215346] Subtest ctm-max: SUCCESS (4.796s)
[134.030566] [018/133] (884s left) gem_exec_params (rel-constants-invalid)
[134.099589] Starting subtest: rel-constants-invalid
[134.101791] Subtest rel-constants-invalid: SUCCESS (0.000s)
[134.222409] [019/133] (884s left) gem_exec_schedule (noreorder-corked)
[134.409586] Starting subtest: noreorder-corked
[134.412123] Starting dynamic subtest: rcs0
[135.561665] Dynamic subtest rcs0: SUCCESS (1.154s)
[135.573227] Starting dynamic subtest: vcs0
[136.929372] Dynamic subtest vcs0: SUCCESS (1.364s)
[136.939859] Starting dynamic subtest: vcs1
[138.935215] Dynamic subtest vcs1: SUCCESS (2.004s)
[138.945911] Starting dynamic subtest: vecs0
[140.889100] Dynamic subtest vecs0: SUCCESS (1.950s)
[140.899383] Starting dynamic subtest: ccs0
[142.045994] Dynamic subtest ccs0: SUCCESS (1.156s)
[142.048847] Subtest noreorder-corked: SUCCESS (7.639s)
[142.240505] [020/133] (876s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[142.303767] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[142.361345] [021/133] (876s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[142.751421] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[143.525356] [022/133] (875s left) gem_exec_whisper (basic-contexts-priority-all)
[143.594039] Starting subtest: basic-contexts-priority-all
[165.856766] Subtest basic-contexts-priority-all: SUCCESS (22.255s)
[166.048903] [023/133] (852s left) gen9_exec_parse (allowed-all)
[166.107328] Subtest allowed-all: SKIP (0.000s)
[166.192885] [024/133] (852s left) perf_pmu (busy-accuracy-98)
[166.230745] Starting subtest: busy-accuracy-98
[166.232954] Starting dynamic subtest: rcs0
[169.324715] Dynamic subtest rcs0: SUCCESS (3.040s)
[169.334599] Starting dynamic subtest: bcs0
[172.369278] Dynamic subtest bcs0: SUCCESS (3.046s)
[172.379162] Starting dynamic subtest: vcs0
[175.409217] Dynamic subtest vcs0: SUCCESS (3.037s)
[175.419681] Starting dynamic subtest: vcs1
[178.449875] Dynamic subtest vcs1: SUCCESS (3.040s)
[178.460527] Starting dynamic subtest: vecs0
[181.489848] Dynamic subtest vecs0: SUCCESS (3.038s)
[181.500621] Starting dynamic subtest: ccs0
[184.539664] Dynamic subtest ccs0: SUCCESS (3.048s)
[184.541915] Subtest busy-accuracy-98: SUCCESS (18.258s)
[184.615974] [025/133] (834s left) gem_workarounds (suspend-resume-fd)
[184.684832] Starting subtest: suspend-resume-fd
[200.914094] Subtest suspend-resume-fd: SUCCESS (1.342s)
[201.086776] [026/133] (817s left) kms_psr (fbc-pr-sprite-plane-move)
[201.205544] Starting subtest: fbc-pr-sprite-plane-move
[201.209923] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[201.306617] [027/133] (817s left) syncobj_wait (invalid-wait-bad-flags)
[201.366355] Starting subtest: invalid-wait-bad-flags
[201.368308] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[201.473575] [028/133] (817s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[201.574284] Starting subtest: fbc-rgb565-draw-mmap-wc
[205.697323] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.029s)
[206.866036] [029/133] (812s left) kms_addfb_basic (unused-offsets)
[206.924356] Starting subtest: unused-offsets
[206.926422] Subtest unused-offsets: SUCCESS (0.000s)
[207.099304] [030/133] (811s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[207.161003] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[207.163322] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[207.284982] [031/133] (811s left) kms_psr (fbc-pr-cursor-plane-move)
[207.370558] Starting subtest: fbc-pr-cursor-plane-move
[207.375026] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[207.456609] [032/133] (811s left) kms_psr (psr-cursor-render)
[207.565143] Starting subtest: psr-cursor-render
[207.567519] Starting dynamic subtest: eDP-1
[209.268414] Dynamic subtest eDP-1: SUCCESS (1.682s)
[209.270842] Subtest psr-cursor-render: SUCCESS (1.683s)
[210.156723] [033/133] (808s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[210.259565] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[210.273532] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.012s)
[210.398117] [034/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[210.507389] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[210.511711] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[210.646743] [035/133] (808s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[210.742403] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[210.746893] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[210.827558] [036/133] (808s left) kms_addfb_basic (invalid-get-prop)
[210.893836] Starting subtest: invalid-get-prop
[210.895968] Subtest invalid-get-prop: SUCCESS (0.000s)
[211.038585] [037/133] (808s left) gem_softpin (evict-prime-sanity-check)
[211.103972] Starting subtest: evict-prime-sanity-check
[211.105728] Starting dynamic subtest: rcs0
[212.323142] Dynamic subtest rcs0: SUCCESS (1.207s)
[212.336054] Starting dynamic subtest: bcs0
[213.474997] Dynamic subtest bcs0: SUCCESS (1.143s)
[213.485124] Starting dynamic subtest: vcs0
[214.761960] Dynamic subtest vcs0: SUCCESS (1.276s)
[214.774088] Starting dynamic subtest: vcs1
[216.790356] Dynamic subtest vcs1: SUCCESS (2.015s)
[216.802893] Starting dynamic subtest: vecs0
[218.827006] Dynamic subtest vecs0: SUCCESS (2.027s)
[218.840066] Starting dynamic subtest: ccs0
[219.970989] Dynamic subtest ccs0: SUCCESS (1.139s)
[219.984169] Starting dynamic subtest: all
[221.109699] Dynamic subtest all: SUCCESS (1.134s)
[221.112296] Subtest evict-prime-sanity-check: SUCCESS (9.952s)
[221.205857] [038/133] (798s left) i915_suspend (fence-restore-untiled)
[221.272322] Starting subtest: fence-restore-untiled
[221.276916] Subtest fence-restore-untiled: SKIP (0.000s)
[221.390657] [039/133] (797s left) kms_psr (psr-sprite-mmap-gtt)
[221.481528] Starting subtest: psr-sprite-mmap-gtt
[221.483831] Starting dynamic subtest: eDP-1
[222.936560] Dynamic subtest eDP-1: SKIP (1.449s)
[222.941650] Subtest psr-sprite-mmap-gtt: SKIP (1.451s)
[223.125492] [040/133] (796s left) gem_userptr_blits (unsync-unmap)
[223.191660] Subtest unsync-unmap: SKIP (0.000s)
[223.352715] [041/133] (796s left) gem_exec_balancer (bonded-true-hang)
[223.615795] Starting subtest: bonded-true-hang
[223.620660] Subtest bonded-true-hang: SKIP (0.000s)
[223.739228] [042/133] (795s left) gem_lmem_swapping (parallel-random-engines)
[223.780894] Subtest parallel-random-engines: SKIP (0.000s)
[223.824496] [043/133] (795s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[223.872446] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[223.876939] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[224.068086] [044/133] (795s left) syncobj_timeline (etime-single-wait-all-submitted)
[224.123072] Starting subtest: etime-single-wait-all-submitted
[224.222711] Subtest etime-single-wait-all-submitted: SUCCESS (0.101s)
[224.312098] [045/133] (795s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[224.418776] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[224.422903] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[224.542348] [046/133] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[224.630866] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[224.635112] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[224.747538] [047/133] (794s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[224.863903] Starting subtest: short-busy-flip-before-cursor-toggle
[224.868383] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[225.018683] [048/133] (794s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[225.123154] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[232.206967] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.076s)
[232.354733] [049/133] (787s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[232.439162] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[232.441481] Starting dynamic subtest: pipe-A-eDP-1
[232.464500] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[232.476662] Starting dynamic subtest: pipe-B-eDP-1
[232.498108] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.507848] Starting dynamic subtest: pipe-C-eDP-1
[232.529464] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.538790] Starting dynamic subtest: pipe-D-eDP-1
[232.560989] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.565309] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[234.661091] [050/133] (785s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[234.765752] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[234.768121] Starting dynamic subtest: pipe-A-eDP-1
[234.788785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[234.800340] Starting dynamic subtest: pipe-B-eDP-1
[234.820248] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[234.829908] Starting dynamic subtest: pipe-C-eDP-1
[234.849698] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[234.859736] Starting dynamic subtest: pipe-D-eDP-1
[234.879435] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[234.881722] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[236.936717] [051/133] (782s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[237.053657] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[237.057823] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[237.182014] [052/133] (782s left) gem_partial_pwrite_pread (reads-snoop)
[237.242178] Subtest reads-snoop: SKIP (0.000s)
[237.326953] [053/133] (782s left) syncobj_timeline (invalid-query-illegal-handle)
[237.384056] Starting subtest: invalid-query-illegal-handle
[237.386243] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[237.485275] [054/133] (782s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[237.603281] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[244.744769] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.137s)
[244.950438] [055/133] (774s left) kms_lease (lease-unleased-connector)
[245.058689] Starting subtest: lease-unleased-connector
[245.060986] Starting dynamic subtest: pipe-A-eDP-1
[245.065778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[245.078310] Starting dynamic subtest: pipe-B-eDP-1
[245.080864] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[245.096824] Starting dynamic subtest: pipe-C-eDP-1
[245.098717] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[245.108248] Starting dynamic subtest: pipe-D-eDP-1
[245.110131] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[245.112057] Subtest lease-unleased-connector: SUCCESS (0.037s)
[245.227007] [056/133] (774s left) syncobj_wait (invalid-single-wait-unsubmitted)
[245.301318] Starting subtest: invalid-single-wait-unsubmitted
[245.303760] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[245.424438] [057/133] (774s left) gem_mmap_gtt (ptrace)
[245.485462] Subtest ptrace: SKIP (0.000s)
[245.549927] [058/133] (774s left) syncobj_timeline (multi-wait-submitted-signaled)
[245.618239] Starting subtest: multi-wait-submitted-signaled
[245.620393] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[245.768435] [059/133] (774s left) gem_madvise (dontneed-before-exec)
[245.801967] Starting subtest: dontneed-before-exec
[245.833157] Subtest dontneed-before-exec: SKIP (0.029s)
[245.902048] [060/133] (774s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[245.996939] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[246.000488] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[246.141795] [061/133] (774s left) gem_ccs (ctrl-surf-copy-new-ctx)
[246.213364] Starting subtest: ctrl-surf-copy-new-ctx
[246.217599] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[246.348110] [062/133] (773s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[246.458652] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[250.872885] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.414s)
[252.049450] [063/133] (768s left) syncobj_wait (single-wait-all-for-submit-signaled)
[252.100151] Starting subtest: single-wait-all-for-submit-signaled
[252.102435] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[252.246771] [064/133] (768s left) gem_ctx_isolation (nonpriv-switch)
[252.317351] Starting subtest: nonpriv-switch
[252.319718] Starting dynamic subtest: rcs0
[252.602096] Dynamic subtest rcs0: SUCCESS (0.284s)
[252.613958] Starting dynamic subtest: bcs0
[252.918868] Dynamic subtest bcs0: SUCCESS (0.315s)
[252.931230] Starting dynamic subtest: vcs0
[253.214095] Dynamic subtest vcs0: SUCCESS (0.295s)
[253.225015] Starting dynamic subtest: vcs1
[255.100778] Dynamic subtest vcs1: SUCCESS (1.884s)
[255.110880] Starting dynamic subtest: vecs0
[257.114832] Dynamic subtest vecs0: SUCCESS (2.012s)
[257.126495] Starting dynamic subtest: ccs0
[259.139658] Dynamic subtest ccs0: SUCCESS (2.023s)
[259.141914] Subtest nonpriv-switch: SUCCESS (6.819s)
[259.409540] [065/133] (760s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[259.505489] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[259.509885] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[259.605136] [066/133] (760s left) i915_drm_fdinfo (most-busy-check-all)
[259.644557] Starting subtest: most-busy-check-all
[259.646840] Starting dynamic subtest: rcs0
[259.651518] Dynamic subtest rcs0: SKIP (0.004s)
[259.667466] Starting dynamic subtest: bcs0
[259.671998] Dynamic subtest bcs0: SKIP (0.000s)
[259.683754] Starting dynamic subtest: vcs0
[259.687806] Dynamic subtest vcs0: SKIP (0.000s)
[259.697286] Starting dynamic subtest: vcs1
[259.701335] Dynamic subtest vcs1: SKIP (0.000s)
[259.710069] Starting dynamic subtest: vecs0
[259.714114] Dynamic subtest vecs0: SKIP (0.000s)
[259.722741] Starting dynamic subtest: ccs0
[259.726838] Dynamic subtest ccs0: SKIP (0.000s)
[259.730835] Subtest most-busy-check-all: SKIP (0.009s)
[259.768426] [067/133] (760s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[259.904268] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[259.906423] Starting dynamic subtest: pipe-A-eDP-1
[259.988492] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[259.998615] Starting dynamic subtest: pipe-B-eDP-1
[261.112950] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[261.117394] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.212s)
[262.328424] [068/133] (758s left) gem_create (create-ext-placement-each)
[262.496906] Starting subtest: create-ext-placement-each
[262.499487] Subtest create-ext-placement-each: SUCCESS (0.000s)
[262.622042] [069/133] (757s left) gen7_exec_parse (basic-allocation)
[262.693058] Subtest basic-allocation: SKIP (0.000s)
[262.760871] [070/133] (757s left) api_intel_bb (intel-bb-blit-none)
[262.811776] Starting subtest: intel-bb-blit-none
[266.633359] Subtest intel-bb-blit-none: SUCCESS (3.821s)
[266.774306] [071/133] (753s left) kms_chamelium_hpd (vga-hpd)
[267.186447] Subtest vga-hpd: SKIP (0.000s)
[268.023202] [072/133] (752s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[268.086824] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[268.159130] [073/133] (752s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[268.229242] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[268.305882] [074/133] (752s left) i915_pm_rps (reset)
[268.383434] Starting subtest: reset
[276.880784] Subtest reset: SUCCESS (8.489s)
[277.032447] [075/133] (743s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[277.155063] Starting subtest: cursor-vs-flip-legacy
[306.573998] Subtest cursor-vs-flip-legacy: SUCCESS (29.401s)
[307.398293] [076/133] (713s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[307.502673] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[307.505044] Starting dynamic subtest: pipe-A-eDP-1
[307.514161] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[307.525438] Starting dynamic subtest: pipe-B-eDP-1
[307.534501] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[307.543941] Starting dynamic subtest: pipe-C-eDP-1
[307.552391] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[307.561852] Starting dynamic subtest: pipe-D-eDP-1
[307.570225] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[307.574318] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[309.695365] [077/133] (711s left) gem_exec_balancer (parallel-keep-in-fence)
[309.957391] Starting subtest: parallel-keep-in-fence
[311.154699] Subtest parallel-keep-in-fence: SUCCESS (1.197s)
[311.282983] [078/133] (709s left) prime_busy (after-wait)
[311.343343] Starting subtest: after-wait
[311.345763] Starting dynamic subtest: rcs0
[311.383318] Dynamic subtest rcs0: SUCCESS (0.040s)
[311.394106] Starting dynamic subtest: bcs0
[311.447012] Dynamic subtest bcs0: SUCCESS (0.063s)
[311.457818] Starting dynamic subtest: vcs0
[311.486691] Dynamic subtest vcs0: SUCCESS (0.039s)
[311.496282] Starting dynamic subtest: vcs1
[311.527833] Dynamic subtest vcs1: SUCCESS (0.040s)
[311.537574] Starting dynamic subtest: vecs0
[311.567215] Dynamic subtest vecs0: SUCCESS (0.039s)
[311.577131] Starting dynamic subtest: ccs0
[311.609128] Dynamic subtest ccs0: SUCCESS (0.041s)
[311.718418] Subtest after-wait: SUCCESS (0.376s)
[311.808070] [079/133] (709s left) gem_exec_schedule (u-independent)
[311.888619] Starting subtest: u-independent
[311.890630] Starting dynamic subtest: rcs0
[313.789907] Dynamic subtest rcs0: SUCCESS (1.906s)
[313.802872] Starting dynamic subtest: vcs0
[315.790050] Dynamic subtest vcs0: SUCCESS (1.997s)
[315.801506] Starting dynamic subtest: vcs1
[317.845913] Dynamic subtest vcs1: SUCCESS (2.052s)
[317.861601] Starting dynamic subtest: vecs0
[319.834579] Dynamic subtest vecs0: SUCCESS (1.984s)
[319.847702] Starting dynamic subtest: ccs0
[321.788296] Dynamic subtest ccs0: SUCCESS (1.950s)
[321.791155] Subtest u-independent: SUCCESS (9.902s)
[322.103166] [080/133] (698s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[322.204816] Starting subtest: fbc-pr-cursor-plane-update-sf
[322.208789] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[322.284525] [081/133] (698s left) kms_sequence (queue-busy)
[322.375375] Starting subtest: queue-busy
[322.377615] Starting dynamic subtest: pipe-A-eDP-1
[324.311902] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[324.323241] Starting dynamic subtest: pipe-B-eDP-1
[326.892109] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.578s)
[326.905929] Starting dynamic subtest: pipe-C-eDP-1
[329.488293] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.592s)
[329.499454] Starting dynamic subtest: pipe-D-eDP-1
[332.030243] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s)
[332.032473] Subtest queue-busy: SUCCESS (9.649s)
[332.923052] [082/133] (688s left) kms_chamelium_audio (hdmi-audio)
[333.305691] Subtest hdmi-audio: SKIP (0.000s)
[334.123919] [083/133] (686s left) gem_mmap_gtt (big-bo-tiledy)
[334.188379] Subtest big-bo-tiledY: SKIP (0.000s)
[334.251574] [084/133] (686s left) gem_mmap_wc (write-prefaulted)
[334.312334] Subtest write-prefaulted: SKIP (0.000s)
[334.379107] [085/133] (686s left) gem_exec_fence (syncobj-unused-fence)
[334.885784] Starting subtest: syncobj-unused-fence
[334.891402] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[336.878557] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[336.881810] [086/133] (684s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[336.939193] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[337.038895] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.101s)
[337.143275] [087/133] (684s left) i915_hangman (engine-engine-hang)
[337.207286] Starting subtest: engine-engine-hang
[337.209389] Starting dynamic subtest: rcs0
[338.780187] Dynamic subtest rcs0: SUCCESS (1.570s)
[338.793691] Starting dynamic subtest: bcs0
[340.763097] Dynamic subtest bcs0: SUCCESS (1.978s)
[340.776688] Starting dynamic subtest: vcs0
[342.746008] Dynamic subtest vcs0: SUCCESS (1.979s)
[342.759587] Starting dynamic subtest: vcs1
[344.794114] Dynamic subtest vcs1: SUCCESS (2.044s)
[344.807482] Starting dynamic subtest: vecs0
[346.778838] Dynamic subtest vecs0: SUCCESS (1.981s)
[346.793465] Starting dynamic subtest: ccs0
[348.762854] Dynamic subtest ccs0: SUCCESS (1.980s)
[348.765695] Subtest engine-engine-hang: SUCCESS (11.549s)
[348.857287] [088/133] (672s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[348.969683] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[348.971995] Starting dynamic subtest: pipe-A-eDP-1
[349.030712] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[349.040068] Starting dynamic subtest: pipe-B-eDP-1
[349.096383] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[349.107874] Starting dynamic subtest: pipe-C-eDP-1
[349.164050] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[349.174911] Starting dynamic subtest: pipe-D-eDP-1
[349.231422] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[349.235840] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[351.225744] [089/133] (670s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[351.328304] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[351.332375] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[351.462043] [090/133] (669s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[351.567054] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[351.571540] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[351.658183] [091/133] (669s left) prime_mmap (test_map_unmap)
[351.718493] Starting subtest: test_map_unmap
[351.720797] Starting dynamic subtest: test_map_unmap-smem
[351.747904] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[351.750252] Subtest test_map_unmap: SUCCESS (0.032s)
[351.885985] [092/133] (669s left) prime_self_import (basic-with_two_bos)
[351.931541] Starting subtest: basic-with_two_bos
[351.948109] Subtest basic-with_two_bos: SUCCESS (0.018s)
[352.066763] [093/133] (669s left) sysfs_preempt_timeout (invalid)
[352.136592] Starting subtest: invalid
[352.138976] Starting dynamic subtest: vecs0
[352.141063] Dynamic subtest vecs0: SUCCESS (0.000s)
[352.152067] Starting dynamic subtest: ccs0
[352.153738] Dynamic subtest ccs0: SUCCESS (0.000s)
[352.162797] Starting dynamic subtest: vcs0
[352.164403] Dynamic subtest vcs0: SUCCESS (0.000s)
[352.173734] Starting dynamic subtest: bcs0
[352.175300] Dynamic subtest bcs0: SUCCESS (0.000s)
[352.184354] Starting dynamic subtest: rcs0
[352.185948] Dynamic subtest rcs0: SUCCESS (0.000s)
[352.195106] Starting dynamic subtest: vcs1
[352.196736] Dynamic subtest vcs1: SUCCESS (0.000s)
[352.198301] Subtest invalid: SUCCESS (0.006s)
[352.275245] [094/133] (669s left) kms_big_fb (linear-64bpp-rotate-180)
[352.369997] Starting subtest: linear-64bpp-rotate-180
[353.949879] Subtest linear-64bpp-rotate-180: SUCCESS (1.578s)
[354.117379] [095/133] (667s left) gem_tiled_pread_pwrite
[354.236280] [096/133] (667s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[354.328581] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[359.566139] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.238s)
[360.733687] [097/133] (660s left) gem_fence_thrash (bo-write-verify-y)
[360.774919] Starting subtest: bo-write-verify-y
[360.795373] Subtest bo-write-verify-y: SKIP (0.017s)
[360.861452] [098/133] (660s left) kms_big_fb (4-tiled-addfb)
[360.961495] Starting subtest: 4-tiled-addfb
[360.963879] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[361.093908] [099/133] (660s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[361.192031] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[365.690081] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.499s)
[366.830789] [100/133] (654s left) gem_exec_fence (syncobj-timeline-chain-engines)
[367.390007] Starting subtest: syncobj-timeline-chain-engines
[367.525976] Subtest syncobj-timeline-chain-engines: SUCCESS (0.136s)
[368.901086] [101/133] (652s left) kms_pm_rpm (modeset-non-lpsp)
[371.031291] Starting subtest: modeset-non-lpsp
[372.174045] Subtest modeset-non-lpsp: SKIP (1.145s)
[372.568450] [102/133] (649s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[372.663839] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[372.794271] [103/133] (649s left) kms_cursor_crc (cursor-size-hints)
[372.933414] Starting subtest: cursor-size-hints
[372.935734] Starting dynamic subtest: pipe-A-eDP-1
[373.545103] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s)
[373.555185] Starting dynamic subtest: pipe-D-eDP-1
[374.812557] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.267s)
[374.814941] Subtest cursor-size-hints: SUCCESS (1.879s)
[375.644563] [104/133] (646s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[375.749438] Starting subtest: yf-tiled-addfb-size-overflow
[375.753914] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[375.878071] [105/133] (646s left) gem_pxp (verify-pxp-stale-ctx-execution)
[376.013507] Starting subtest: verify-pxp-stale-ctx-execution
[377.072016] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.060s)
[377.230798] [106/133] (644s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[377.355880] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[378.390383] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.033s)
[378.561537] [107/133] (643s left) kms_psr (psr2-cursor-mmap-cpu)
[378.653846] Starting subtest: psr2-cursor-mmap-cpu
[378.655759] Starting dynamic subtest: eDP-1
[380.387698] Dynamic subtest eDP-1: SUCCESS (1.731s)
[380.390055] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.733s)
[381.217021] [108/133] (640s left) kms_psr (fbc-psr-sprite-plane-onoff)
[381.314717] Starting subtest: fbc-psr-sprite-plane-onoff
[381.317113] Starting dynamic subtest: eDP-1
[381.321686] Dynamic subtest eDP-1: SKIP (0.000s)
[381.326209] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[381.399696] [109/133] (640s left) kms_pm_rpm (fences-dpms)
[382.939982] Starting subtest: fences-dpms
[382.944699] Subtest fences-dpms: SKIP (0.000s)
[383.747028] [110/133] (638s left) prime_mmap_coherency (read)
[383.814034] Starting subtest: read
[389.244550] Subtest read: SUCCESS (5.375s)
[389.352477] [111/133] (632s left) gem_exec_fence (basic-busy-all)
[389.417172] Starting subtest: basic-busy-all
[389.530984] Subtest basic-busy-all: SUCCESS (0.114s)
[391.913612] [112/133] (630s left) prime_vgem (basic-fence-flip)
[392.002051] Starting subtest: basic-fence-flip
[392.292242] Subtest basic-fence-flip: SUCCESS (0.290s)
[392.436475] [113/133] (629s left) syncobj_wait (invalid-signal-bad-pad)
[392.504364] Starting subtest: invalid-signal-bad-pad
[392.506532] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[392.634012] [114/133] (629s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[392.740644] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[392.744807] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[392.880550] [115/133] (629s left) kms_big_fb (x-tiled-addfb)
[392.983737] Starting subtest: x-tiled-addfb
[392.986095] Subtest x-tiled-addfb: SUCCESS (0.000s)
[393.115764] [116/133] (629s left) gem_ctx_persistence (legacy-engines-hostile)
[393.177721] Starting subtest: legacy-engines-hostile
[393.180212] Starting dynamic subtest: render
[393.298523] Dynamic subtest render: SUCCESS (0.120s)
[393.313599] Starting dynamic subtest: bsd1
[393.415304] Dynamic subtest bsd1: SUCCESS (0.114s)
[393.430663] Starting dynamic subtest: bsd2
[393.516255] Dynamic subtest bsd2: SUCCESS (0.098s)
[393.528940] Starting dynamic subtest: blt
[393.641837] Dynamic subtest blt: SUCCESS (0.124s)
[393.656511] Starting dynamic subtest: vebox
[393.761242] Dynamic subtest vebox: SUCCESS (0.116s)
[393.763588] Subtest legacy-engines-hostile: SUCCESS (0.585s)
[393.859895] [117/133] (628s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[393.970326] Starting subtest: 4-tiled-16bpp-rotate-180
[395.261386] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.289s)
[395.434838] [118/133] (627s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[395.534626] Starting subtest: compare-crc-sanitycheck-nv12
[395.536704] Starting dynamic subtest: pipe-A-eDP-1
[396.250487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[396.262342] Starting dynamic subtest: pipe-B-eDP-1
[397.547349] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.295s)
[397.558043] Starting dynamic subtest: pipe-C-eDP-1
[398.769220] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.219s)
[398.780374] Starting dynamic subtest: pipe-D-eDP-1
[400.018781] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.246s)
[400.020574] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.481s)
[400.857693] [119/133] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[400.958282] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[407.636190] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.676s)
[407.811255] [120/133] (614s left) kms_flip (wf_vblank-ts-check-interruptible)
[407.910871] Starting subtest: wf_vblank-ts-check-interruptible
[407.913178] Starting dynamic subtest: A-eDP1
[416.841475] Dynamic subtest A-eDP1: SUCCESS (8.893s)
[416.851671] Starting dynamic subtest: B-eDP1
[425.783665] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[425.795671] Starting dynamic subtest: C-eDP1
[434.716104] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[434.728310] Starting dynamic subtest: D-eDP1
[443.656016] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[443.658432] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.689s)
[444.855387] [121/133] (577s left) gem_eio (create)
[445.096488] Starting subtest: create
[445.451077] Subtest create: SUCCESS (0.355s)
[445.633825] [122/133] (577s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[445.772909] Starting subtest: dp-mst-lic-type-0-hdcp14
[445.776497] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[445.924466] [123/133] (576s left) kms_vblank (query-idle)
[446.010765] Starting subtest: query-idle
[446.012452] Starting dynamic subtest: pipe-A-eDP-1
[447.780695] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.767s)
[447.796511] Starting dynamic subtest: pipe-D-eDP-1
[450.189624] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.404s)
[450.191936] Subtest query-idle: SUCCESS (4.175s)
[451.051733] [124/133] (571s left) kms_plane_scaling (invalid-num-scalers)
[451.148671] Starting subtest: invalid-num-scalers
[451.150982] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[451.166139] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[451.177082] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[451.200826] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[451.211274] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[451.233617] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[451.244262] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[451.265925] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[451.268098] Subtest invalid-num-scalers: SUCCESS (0.120s)
[451.409142] [125/133] (571s left) kms_cursor_crc (cursor-onscreen-512x170)
[451.727445] Starting subtest: cursor-onscreen-512x170
[451.731867] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[451.928835] [126/133] (570s left) kms_rotation_crc (primary-rotation-270)
[452.022966] Starting subtest: primary-rotation-270
[452.026555] Subtest primary-rotation-270: SKIP (0.001s)
[452.105880] [127/133] (570s left) perf (invalid-oa-metric-set-id)
[452.197765] Starting subtest: invalid-oa-metric-set-id
[452.206191] Subtest invalid-oa-metric-set-id: SUCCESS (0.007s)
[452.252639] [128/133] (570s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[452.308137] Starting subtest: single-wait-all-for-submit-available-submitted
[452.310099] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[452.430604] [129/133] (570s left) kms_draw_crc (draw-method-render)
[452.517821] Starting subtest: draw-method-render
[452.519671] Starting dynamic subtest: xrgb8888-untiled
[452.761963] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[452.773771] Starting dynamic subtest: rgb565-untiled
[452.995438] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[453.005549] Starting dynamic subtest: xrgb2101010-untiled
[453.206947] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[453.219478] Starting dynamic subtest: xbgr16161616f-untiled
[453.451092] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[453.461568] Starting dynamic subtest: xrgb8888-xtiled
[453.573541] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[453.583849] Starting dynamic subtest: rgb565-xtiled
[453.684466] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[453.694748] Starting dynamic subtest: xrgb2101010-xtiled
[453.806802] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[453.818983] Starting dynamic subtest: xbgr16161616f-xtiled
[453.940401] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[453.950851] Starting dynamic subtest: xrgb8888-4tiled
[454.062739] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[454.073329] Starting dynamic subtest: rgb565-4tiled
[454.173826] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[454.184115] Starting dynamic subtest: xrgb2101010-4tiled
[454.296199] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[454.306699] Starting dynamic subtest: xbgr16161616f-4tiled
[454.418499] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.121s)
[454.420478] Subtest draw-method-render: SUCCESS (1.901s)
[454.583005] [130/133] (568s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[454.715674] Starting subtest: basic-flip-before-cursor-legacy
[455.640065] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.922s)
[456.477564] [131/133] (566s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[456.589699] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[456.593765] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[456.718874] [132/133] (566s left) perf_pmu (idle-no-semaphores)
[456.764221] Starting subtest: idle-no-semaphores
[456.766317] Starting dynamic subtest: rcs0
[457.328906] Dynamic subtest rcs0: SUCCESS (0.564s)
[457.340427] Starting dynamic subtest: bcs0
[457.845308] Dynamic subtest bcs0: SUCCESS (0.522s)
[457.857243] Starting dynamic subtest: vcs0
[458.372690] Dynamic subtest vcs0: SUCCESS (0.535s)
[458.382896] Starting dynamic subtest: vcs1
[458.896393] Dynamic subtest vcs1: SUCCESS (0.528s)
[458.909583] Starting dynamic subtest: vecs0
[459.413867] Dynamic subtest vecs0: SUCCESS (0.522s)
[459.426847] Starting dynamic subtest: ccs0
[459.938655] Dynamic subtest ccs0: SUCCESS (0.529s)
[459.941412] Subtest idle-no-semaphores: SUCCESS (3.219s)
[460.073737] [133/133] (563s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[460.137084] Starting subtest: multi-wait-all-for-submit-signaled
[460.139406] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[460.250173] 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.