[60.278393] Initializing watchdogs
[60.278443]   /dev/watchdog0
[60.293443] [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]
[60.298031] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.300439] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.303947] [001/131] (960s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[60.385824] Subtest untiled-to-tiled: SKIP (0.000s)
[60.449611] [002/131] (960s left) kms_force_connector_basic (force-edid)
[60.524475] Starting subtest: force-edid
[60.919562] Subtest force-edid: SUCCESS (0.391s)
[61.066559] [003/131] (959s left) kms_dsc (dsc-with-output-formats)
[61.166105] Starting subtest: dsc-with-output-formats
[61.184350] Subtest dsc-with-output-formats: SKIP (0.001s)
[61.245669] [004/131] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[61.353073] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[61.356618] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[61.483379] [005/131] (959s left) gem_spin_batch (legacy-resubmit)
[61.552989] Starting subtest: legacy-resubmit
[61.555071] Starting dynamic subtest: default
[61.559527] Dynamic subtest default: SUCCESS (0.006s)
[61.566404] Starting dynamic subtest: render
[61.568528] Dynamic subtest render: SUCCESS (0.001s)
[61.577408] Starting dynamic subtest: bsd
[61.579245] Dynamic subtest bsd: SUCCESS (0.002s)
[61.585684] Starting dynamic subtest: bsd1
[61.587562] Dynamic subtest bsd1: SUCCESS (0.001s)
[61.593935] Starting dynamic subtest: bsd2
[61.595837] Dynamic subtest bsd2: SUCCESS (0.003s)
[61.602082] Starting dynamic subtest: blt
[61.603929] Dynamic subtest blt: SUCCESS (0.002s)
[61.610150] Starting dynamic subtest: vebox
[61.611976] Dynamic subtest vebox: SUCCESS (0.002s)
[61.613854] Subtest legacy-resubmit: SUCCESS (0.018s)
[61.845639] [006/131] (959s left) kms_chamelium_audio (hdmi-audio-edid)
[62.238785] Subtest hdmi-audio-edid: SKIP (0.000s)
[63.040689] [007/131] (957s left) perf (gen12-mi-rpc)
[63.179392] Starting subtest: gen12-mi-rpc
[63.181751] Starting dynamic subtest: rcs0
[63.196665] Dynamic subtest rcs0: SUCCESS (0.017s)
[63.198828] Subtest gen12-mi-rpc: SUCCESS (0.017s)
[63.238874] [008/131] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[63.339447] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[69.771053] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.394s)
[69.929086] [009/131] (951s left) gem_exec_schedule (submit-late-slice)
[70.003282] Starting subtest: submit-late-slice
[70.005508] Starting dynamic subtest: rcs0
[70.034263] Dynamic subtest rcs0: SUCCESS (0.037s)
[70.042683] Starting dynamic subtest: bcs0
[70.064856] Dynamic subtest bcs0: SUCCESS (0.030s)
[70.072518] Starting dynamic subtest: vcs0
[70.095276] Dynamic subtest vcs0: SUCCESS (0.030s)
[70.107854] Starting dynamic subtest: vcs1
[70.124336] Dynamic subtest vcs1: SUCCESS (0.028s)
[70.131595] Starting dynamic subtest: vecs0
[70.151488] Dynamic subtest vecs0: SUCCESS (0.027s)
[70.162725] Starting dynamic subtest: ccs0
[70.178933] Dynamic subtest ccs0: SUCCESS (0.027s)
[70.181435] Subtest submit-late-slice: SUCCESS (0.182s)
[72.014109] [010/131] (949s left) kms_plane_multiple (2x-tiling-none)
[72.133292] Starting subtest: 2x-tiling-none
[72.137899] Subtest 2x-tiling-none: SKIP (0.000s)
[72.256948] [011/131] (948s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[72.357508] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[79.646297] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.280s)
[79.825737] [012/131] (941s left) gem_exec_fence (syncobj-timeline-chain-engines)
[80.371053] Starting subtest: syncobj-timeline-chain-engines
[80.469100] Subtest syncobj-timeline-chain-engines: SUCCESS (0.099s)
[82.006082] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[82.009346] [013/131] (939s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[82.115222] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[82.119714] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[82.239350] [014/131] (939s left) gem_tiled_wc
[82.362599] [015/131] (938s left) perf (create-destroy-userspace-config)
[82.458608] Starting subtest: create-destroy-userspace-config
[82.477806] Subtest create-destroy-userspace-config: SUCCESS (0.018s)
[82.520310] [016/131] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[82.617605] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[82.621985] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[82.755202] [017/131] (938s left) syncobj_timeline (reset-multiple-signaled)
[82.813293] Starting subtest: reset-multiple-signaled
[82.815609] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[82.928862] [018/131] (938s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[83.028165] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[83.030142] Starting dynamic subtest: pipe-A-eDP-1
[83.049500] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.058820] Starting dynamic subtest: pipe-B-eDP-1
[83.076692] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.083599] Starting dynamic subtest: pipe-C-eDP-1
[83.100749] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.107926] Starting dynamic subtest: pipe-D-eDP-1
[83.125679] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.129040] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[85.241427] [019/131] (936s left) gem_exec_reloc (basic-write-cpu-active)
[85.309166] Subtest basic-write-cpu-active: SKIP (0.000s)
[85.389170] [020/131] (936s left) fbdev (unaligned-write)
[85.430750] Starting subtest: unaligned-write
[85.530840] Subtest unaligned-write: SUCCESS (0.100s)
[85.606196] [021/131] (935s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[85.712290] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[85.716262] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[85.830976] [022/131] (935s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[85.922461] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[85.926990] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[86.047745] [023/131] (935s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[86.149124] Starting subtest: fbc-psr2-cursor-mmap-gtt
[86.151074] Starting dynamic subtest: eDP-1
[86.155197] Dynamic subtest eDP-1: SKIP (0.000s)
[86.159326] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[86.243322] [024/131] (935s left) kms_pm_rpm (modeset-lpsp-stress)
[88.005080] Starting subtest: modeset-lpsp-stress
[104.221651] Subtest modeset-lpsp-stress: SUCCESS (16.209s)
[104.330320] [025/131] (917s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[104.433965] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[104.436259] Starting dynamic subtest: pipe-A-eDP-1
[104.459654] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[104.472715] Starting dynamic subtest: pipe-B-eDP-1
[104.494681] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[104.503356] Starting dynamic subtest: pipe-C-eDP-1
[104.525935] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[104.533940] Starting dynamic subtest: pipe-D-eDP-1
[104.554880] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[104.558723] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[106.651927] [026/131] (915s left) api_intel_bb (add-remove-objects)
[106.713446] Starting subtest: add-remove-objects
[106.718696] Subtest add-remove-objects: SUCCESS (0.006s)
[106.864700] [027/131] (914s left) gem_madvise (dontneed-before-pwrite)
[106.900029] Starting subtest: dontneed-before-pwrite
[106.926652] Subtest dontneed-before-pwrite: SKIP (0.024s)
[106.982129] [028/131] (914s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[107.085159] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[107.089690] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[107.200879] [029/131] (914s left) gem_ctx_persistence (file)
[107.264645] Starting subtest: file
[107.396064] Subtest file: SUCCESS (0.131s)
[107.525110] [030/131] (914s left) i915_drm_fdinfo (virtual-idle)
[107.561656] Starting subtest: virtual-idle
[110.654808] Subtest virtual-idle: SUCCESS (3.092s)
[110.743507] [031/131] (911s left) prime_vgem (basic-read)
[110.814096] Starting subtest: basic-read
[110.821778] Subtest basic-read: SKIP (0.005s)
[110.958738] [032/131] (911s left) kms_psr (pr-cursor-plane-move)
[111.052741] Starting subtest: pr-cursor-plane-move
[111.056686] Subtest pr-cursor-plane-move: SKIP (0.000s)
[111.138275] [033/131] (910s left) i915_selftest (perf)
[114.716174] Starting subtest: perf
[114.718636] Starting dynamic subtest: engine_cs
[117.659051] Dynamic subtest engine_cs: SUCCESS (2.945s)
[117.667607] Starting dynamic subtest: request
[123.128133] Dynamic subtest request: SUCCESS (5.467s)
[123.137147] Starting dynamic subtest: migrate
[127.692262] Dynamic subtest migrate: SUCCESS (4.562s)
[127.699738] Starting dynamic subtest: region
[133.709934] Dynamic subtest region: SUCCESS (6.016s)
[133.713058] Subtest perf: SUCCESS (18.996s)
[133.741082] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[133.741835] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[133.744788] [034/131] (888s left) i915_drm_fdinfo (all-busy-idle-check-all)
[135.221624] Starting subtest: all-busy-idle-check-all
[135.233222] Subtest all-busy-idle-check-all: SKIP (0.009s)
[135.279594] [FACT i915_drm_fdinfo (all-busy-idle-check-all)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[135.281397] [FACT i915_drm_fdinfo (all-busy-idle-check-all)] new: kernel.kmod_is_loaded.i915: true
[135.285226] [035/131] (886s left) kms_pm_rpm (modeset-stress-extra-wait)
[137.115206] Starting subtest: modeset-stress-extra-wait
[191.342812] Subtest modeset-stress-extra-wait: SUCCESS (54.229s)
[191.443548] [036/131] (830s left) i915_pm_rpm (system-suspend-execbuf)
[193.097982] Starting subtest: system-suspend-execbuf
[252.847380] Subtest system-suspend-execbuf: SUCCESS (44.675s)
[253.223127] [037/131] (768s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[253.297010] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[253.302236] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[253.491770] [038/131] (768s left) perf (invalid-oa-metric-set-id)
[253.611166] Starting subtest: invalid-oa-metric-set-id
[253.622078] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[253.666959] [039/131] (768s left) gem_mmap_gtt (cpuset-basic-small-copy)
[253.715726] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[253.778318] [040/131] (768s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[254.159874] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[255.019482] [041/131] (767s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[255.126344] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[255.131228] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[255.231497] [042/131] (767s left) api_intel_bb (simple-bb)
[255.291932] Starting subtest: simple-bb
[255.296091] Subtest simple-bb: SUCCESS (0.008s)
[255.450604] [043/131] (767s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[255.549879] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[255.555208] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[255.651241] [044/131] (766s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[255.747056] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[262.345869] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.600s)
[262.481495] [045/131] (760s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[262.598435] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[262.603600] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[262.723429] [046/131] (759s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[262.834819] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[274.014675] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.172s)
[274.908491] [047/131] (747s left) gem_linear_blits (normal)
[275.248684] Starting subtest: normal
[279.146174] Subtest normal: SUCCESS (3.899s)
[279.357731] [048/131] (743s left) gem_pxp (protected-raw-src-copy-not-readible)
[279.531816] Starting subtest: protected-raw-src-copy-not-readible
[279.593799] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.064s)
[279.756969] [049/131] (742s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[279.873374] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[279.878779] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[279.992763] [050/131] (742s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[280.095029] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[287.716846] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.623s)
[287.852673] [051/131] (734s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[287.962683] Starting subtest: yf-tiled-16bpp-rotate-180
[287.967606] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[288.075652] [052/131] (734s left) core_getstats (basic)
[288.129919] Starting subtest: basic
[288.132789] Subtest basic: SUCCESS (0.000s)
[288.254757] [053/131] (734s left) kms_addfb_basic (invalid-get-prop)
[288.320075] Starting subtest: invalid-get-prop
[288.322550] Subtest invalid-get-prop: SUCCESS (0.000s)
[288.495947] [054/131] (734s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[293.481005] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[293.485908] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[294.351359] [055/131] (728s left) kms_addfb_basic (invalid-get-prop-any)
[294.405117] Starting subtest: invalid-get-prop-any
[294.407232] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[294.547099] [056/131] (728s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[294.647990] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[294.653006] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[294.769976] [057/131] (728s left) gem_exec_store (dword)
[294.835022] Starting subtest: dword
[294.837562] Starting dynamic subtest: rcs0
[294.917719] Dynamic subtest rcs0: SUCCESS (0.086s)
[294.931131] Starting dynamic subtest: bcs0
[294.960574] Dynamic subtest bcs0: SUCCESS (0.041s)
[294.971214] Starting dynamic subtest: vcs0
[295.001364] Dynamic subtest vcs0: SUCCESS (0.039s)
[295.011208] Starting dynamic subtest: vcs1
[295.044387] Dynamic subtest vcs1: SUCCESS (0.041s)
[295.054844] Starting dynamic subtest: vecs0
[295.087232] Dynamic subtest vecs0: SUCCESS (0.041s)
[295.097089] Starting dynamic subtest: ccs0
[295.129926] Dynamic subtest ccs0: SUCCESS (0.041s)
[295.132819] Subtest dword: SUCCESS (0.300s)
[295.325853] [058/131] (727s left) gem_sync (basic-each)
[295.398897] Starting subtest: basic-each
[297.791385] Subtest basic-each: SUCCESS (2.405s)
[297.992551] [059/131] (725s left) gem_readwrite (write-bad-handle)
[298.060005] Subtest write-bad-handle: SKIP (0.000s)
[298.127423] [060/131] (725s left) sw_sync (alloc_fence)
[298.175269] Starting subtest: alloc_fence
[298.178139] Subtest alloc_fence: SUCCESS (0.000s)
[298.255864] [061/131] (724s left) sriov_basic (enable-vfs-autoprobe-off)
[298.310377] Starting subtest: enable-vfs-autoprobe-off
[298.313101] Starting dynamic subtest: numvfs-1
[298.396135] Dynamic subtest numvfs-1: FAIL (0.029s)
[298.408213] Starting dynamic subtest: numvfs-2
[298.493756] Dynamic subtest numvfs-2: FAIL (0.004s)
[298.503977] Starting dynamic subtest: numvfs-3
[298.587855] Dynamic subtest numvfs-3: FAIL (0.004s)
[298.597927] Starting dynamic subtest: numvfs-4
[298.681052] Dynamic subtest numvfs-4: FAIL (0.004s)
[298.690826] Starting dynamic subtest: numvfs-5
[298.775184] Dynamic subtest numvfs-5: FAIL (0.004s)
[298.784691] Starting dynamic subtest: numvfs-6
[298.867302] Dynamic subtest numvfs-6: FAIL (0.004s)
[298.876446] Starting dynamic subtest: numvfs-7
[298.946958] Dynamic subtest numvfs-7: FAIL (0.003s)
[298.956104] Starting dynamic subtest: numvfs-random
[299.028530] Dynamic subtest numvfs-random: FAIL (0.004s)
[299.037967] Starting dynamic subtest: numvfs-all
[299.105331] Dynamic subtest numvfs-all: FAIL (0.566s)
[299.107217] Subtest enable-vfs-autoprobe-off: FAIL (0.629s)
[299.148599] [062/131] (724s left) gem_exec_reloc (basic-concurrent0)
[299.203656] Subtest basic-concurrent0: SKIP (0.000s)
[299.283593] [063/131] (724s left) gem_mmap_offset (isolation)
[299.343823] Starting subtest: isolation
[299.359437] Subtest isolation: SUCCESS (0.008s)
[299.486324] [064/131] (723s left) kms_vblank (query-busy-hang)
[299.580529] Starting subtest: query-busy-hang
[299.582569] Starting dynamic subtest: pipe-A-eDP-1
[326.450185] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.875s)
[326.467179] Starting dynamic subtest: pipe-D-eDP-1
[341.475753] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.028s)
[341.478103] Subtest query-busy-hang: SUCCESS (41.908s)
[342.310293] [065/131] (681s left) kms_setmode (invalid-clone-exclusive-crtc)
[342.368022] Starting subtest: invalid-clone-exclusive-crtc
[342.376713] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[342.491083] [066/131] (680s left) kms_flip (flip-vs-expired-vblank-interruptible)
[342.589749] Starting subtest: flip-vs-expired-vblank-interruptible
[342.592124] Starting dynamic subtest: A-eDP1
[351.290177] Dynamic subtest A-eDP1: SUCCESS (8.701s)
[351.300127] Starting dynamic subtest: B-eDP1
[359.930708] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[359.941775] Starting dynamic subtest: C-eDP1
[368.557213] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[368.566851] Starting dynamic subtest: D-eDP1
[377.187145] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[377.193224] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.600s)
[378.378526] [067/131] (645s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[378.488217] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[379.646650] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.158s)
[379.770676] [068/131] (643s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[379.870498] Starting subtest: plane-downscale-factor-0-5-with-rotation
[379.872633] Starting dynamic subtest: pipe-A
[379.890541] Dynamic subtest pipe-A: SKIP (0.015s)
[379.899834] Starting dynamic subtest: pipe-B
[379.917226] Dynamic subtest pipe-B: SKIP (0.029s)
[379.926393] Starting dynamic subtest: pipe-C
[379.948437] Dynamic subtest pipe-C: SKIP (0.029s)
[379.957031] Starting dynamic subtest: pipe-D
[379.976610] Dynamic subtest pipe-D: SKIP (0.029s)
[379.980356] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.104s)
[380.090739] [069/131] (643s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[380.136921] Starting subtest: multi-wait-all-available-submitted-signaled
[380.139007] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[380.241629] [070/131] (643s left) kms_lease (invalid-create-leases)
[380.334842] Starting subtest: invalid-create-leases
[380.341423] Subtest invalid-create-leases: SUCCESS (0.007s)
[380.460392] [071/131] (643s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[380.558809] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[384.602246] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.047s)
[385.802004] [072/131] (637s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[385.899832] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[385.902210] Starting dynamic subtest: pipe-A-default-mode
[386.189363] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[386.194823] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.286s)
[387.028010] [073/131] (636s left) gem_exec_schedule (preempt-other-chain)
[387.099408] Starting subtest: preempt-other-chain
[387.101431] Starting dynamic subtest: rcs0
[387.178800] Dynamic subtest rcs0: SUCCESS (0.090s)
[387.191522] Starting dynamic subtest: bcs0
[387.261841] Dynamic subtest bcs0: SUCCESS (0.080s)
[387.275012] Starting dynamic subtest: vcs0
[387.339025] Dynamic subtest vcs0: SUCCESS (0.077s)
[387.353487] Starting dynamic subtest: vcs1
[387.414779] Dynamic subtest vcs1: SUCCESS (0.075s)
[387.429690] Starting dynamic subtest: vecs0
[387.490948] Dynamic subtest vecs0: SUCCESS (0.076s)
[387.504171] Starting dynamic subtest: ccs0
[387.569601] Dynamic subtest ccs0: SUCCESS (0.077s)
[387.572217] Subtest preempt-other-chain: SUCCESS (0.480s)
[388.787992] [074/131] (634s left) kms_chamelium_edid (vga-edid-read)
[389.174124] Subtest vga-edid-read: SKIP (0.000s)
[390.063484] [075/131] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[390.160886] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[390.165966] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[390.271398] [076/131] (633s left) kms_cursor_legacy (single-bo)
[390.396227] Starting subtest: single-bo
[390.398534] Starting dynamic subtest: pipe-A
[395.779454] Dynamic subtest pipe-A: SUCCESS (5.380s)
[395.791756] Starting dynamic subtest: pipe-B
[401.164583] Dynamic subtest pipe-B: SUCCESS (5.379s)
[401.175876] Starting dynamic subtest: pipe-C
[406.547217] Dynamic subtest pipe-C: SUCCESS (5.381s)
[406.556637] Starting dynamic subtest: pipe-D
[411.931190] Dynamic subtest pipe-D: SUCCESS (5.379s)
[411.941200] Starting dynamic subtest: all-pipes
[417.322929] Dynamic subtest all-pipes: SUCCESS (5.388s)
[417.325534] Subtest single-bo: SUCCESS (26.919s)
[417.479539] [077/131] (606s left) perf (non-system-wide-paranoid)
[417.602372] Starting subtest: non-system-wide-paranoid
[417.628197] Subtest non-system-wide-paranoid: SUCCESS (0.026s)
[417.673948] [078/131] (606s left) gem_exec_balancer (parallel-ordering)
[417.922673] Starting subtest: parallel-ordering
[418.861672] Subtest parallel-ordering: SUCCESS (0.939s)
[418.996495] [079/131] (605s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[419.090225] Starting subtest: basic-max-pipe-crc-check
[419.095011] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[419.141533] [080/131] (604s left) kms_invalid_mode (int-max-clock)
[419.230121] Starting subtest: int-max-clock
[419.232600] Starting dynamic subtest: pipe-A-eDP-1
[419.522003] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[419.534495] Starting dynamic subtest: pipe-B-eDP-1
[419.536639] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[419.545986] Starting dynamic subtest: pipe-C-eDP-1
[419.548763] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[419.558007] Starting dynamic subtest: pipe-D-eDP-1
[419.560319] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[419.562546] Subtest int-max-clock: SUCCESS (0.301s)
[420.402119] [081/131] (603s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[420.458322] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[420.567664] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.108s)
[420.645195] [082/131] (603s left) kms_atomic_transition (modeset-transition-fencing)
[420.743853] Starting subtest: modeset-transition-fencing
[420.745987] Starting dynamic subtest: 1x-outputs
[431.273664] Dynamic subtest 1x-outputs: SUCCESS (10.527s)
[431.539882] Subtest modeset-transition-fencing: SUCCESS (10.792s)
[432.426034] [083/131] (591s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[432.515934] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[432.518383] Starting dynamic subtest: pipe-A-eDP-1
[432.543116] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[432.552970] Starting dynamic subtest: pipe-B-eDP-1
[432.577057] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[432.586831] Starting dynamic subtest: pipe-C-eDP-1
[432.612136] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[432.621173] Starting dynamic subtest: pipe-D-eDP-1
[432.646840] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[432.651896] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[434.678578] [084/131] (589s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[434.780973] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[435.537952] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.759s)
[435.715397] [085/131] (588s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[435.777972] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[435.780186] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[435.882371] [086/131] (588s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[435.973878] Starting subtest: 4-tiled-64bpp-rotate-270
[435.993227] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[436.132584] [087/131] (588s left) vgem_basic (dmabuf-mmap)
[436.173380] Starting subtest: dmabuf-mmap
[436.212893] Subtest dmabuf-mmap: SUCCESS (0.043s)
[436.289852] [088/131] (588s left) kms_cursor_crc (cursor-sliding-128x128)
[436.488798] Starting subtest: cursor-sliding-128x128
[436.490912] Starting dynamic subtest: pipe-A-eDP-1
[439.717260] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.225s)
[439.743936] Starting dynamic subtest: pipe-D-eDP-1
[443.576114] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.839s)
[443.578934] Subtest cursor-sliding-128x128: SUCCESS (7.089s)
[444.469783] [089/131] (579s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[444.524223] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[444.526897] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[444.647173] [090/131] (579s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[444.750422] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[444.763309] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.012s)
[444.867984] [091/131] (579s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[444.933558] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[444.935953] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[445.065514] [092/131] (579s left) kms_cursor_crc (cursor-onscreen-max-size)
[445.366937] Starting subtest: cursor-onscreen-max-size
[445.374134] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[445.510565] [093/131] (579s left) gem_exec_reloc (basic-gtt-wc)
[445.572788] Subtest basic-gtt-wc: SKIP (0.000s)
[445.653888] [094/131] (579s left) gem_mmap_gtt (basic-copy)
[445.707711] Subtest basic-copy: SKIP (0.000s)
[445.777623] [095/131] (578s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[445.877421] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[449.603526] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.730s)
[450.791926] [096/131] (573s left) syncobj_basic (bad-flags-handle-to-fd)
[450.848523] Starting subtest: bad-flags-handle-to-fd
[450.851029] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[450.954021] [097/131] (573s left) kms_concurrent (multi-plane-atomic-lowres)
[451.053328] Starting subtest: multi-plane-atomic-lowres
[451.055927] Starting dynamic subtest: pipe-A-eDP-1
[451.542875] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.489s)
[451.545553] Subtest multi-plane-atomic-lowres: SUCCESS (0.491s)
[452.409602] [098/131] (572s left) kms_sequence (get-forked)
[452.507890] Starting subtest: get-forked
[452.510228] Starting dynamic subtest: pipe-A-eDP-1
[454.377872] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.868s)
[454.388362] Starting dynamic subtest: pipe-B-eDP-1
[456.925665] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.549s)
[456.937957] Starting dynamic subtest: pipe-C-eDP-1
[459.438963] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.512s)
[459.449202] Starting dynamic subtest: pipe-D-eDP-1
[461.968817] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.529s)
[461.971363] Subtest get-forked: SUCCESS (9.464s)
[462.829924] [099/131] (562s left) kms_pm_backlight (bad-brightness)
[462.927220] Starting subtest: bad-brightness
[462.981920] Starting dynamic subtest: eDP-1
[463.289189] Dynamic subtest eDP-1: SUCCESS (0.308s)
[463.291805] Subtest bad-brightness: SUCCESS (0.363s)
[464.163772] [100/131] (560s left) kms_panel_fitting (legacy)
[464.262089] Starting subtest: legacy
[464.264713] Starting dynamic subtest: pipe-A-eDP-1
[464.793657] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.533s)
[464.821953] Starting dynamic subtest: pipe-B-eDP-1
[466.305768] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.492s)
[466.334015] Starting dynamic subtest: pipe-C-eDP-1
[467.823894] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.496s)
[467.857052] Starting dynamic subtest: pipe-D-eDP-1
[469.367158] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.523s)
[469.369402] Subtest legacy: SUCCESS (5.108s)
[470.616506] [101/131] (554s left) gen9_exec_parse (basic-rejected)
[470.683094] Subtest basic-rejected: SKIP (0.000s)
[470.775638] [102/131] (554s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[470.898851] Starting subtest: cursorA-vs-flipB-varying-size
[470.903282] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[471.070625] [103/131] (553s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[471.181954] Starting subtest: psr-rgb101010-draw-pwrite
[478.844468] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.664s)
[478.983637] [104/131] (546s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[479.090884] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[479.095773] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[479.205907] [105/131] (545s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[479.297086] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[479.299901] Starting dynamic subtest: pipe-A-eDP-1
[495.253565] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.462s)
[495.263695] Starting dynamic subtest: pipe-B-eDP-1
[512.162408] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.299s)
[512.172523] Starting dynamic subtest: pipe-C-eDP-1
[529.124293] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.286s)
[529.134474] Starting dynamic subtest: pipe-D-eDP-1
[546.152416] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.238s)
[546.155209] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.291s)
[547.439486] [106/131] (477s left) kms_psr (fbc-pr-cursor-blt)
[547.544616] Starting subtest: fbc-pr-cursor-blt
[547.549770] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[547.632175] [107/131] (477s left) kms_feature_discovery (dp-mst)
[547.726752] Starting subtest: dp-mst
[547.731622] Subtest dp-mst: SKIP (0.000s)
[547.820157] [108/131] (477s left) syncobj_timeline (wait-all-delayed-signal)
[547.885382] Starting subtest: wait-all-delayed-signal
[547.988377] Subtest wait-all-delayed-signal: SUCCESS (0.100s)
[548.094218] [109/131] (477s left) perf_pmu (semaphore-busy)
[548.137524] Starting subtest: semaphore-busy
[548.140483] Starting dynamic subtest: rcs0
[549.816577] Dynamic subtest rcs0: SUCCESS (1.628s)
[549.828409] Starting dynamic subtest: bcs0
[550.453998] Dynamic subtest bcs0: FAIL (0.554s)
[550.463749] Starting dynamic subtest: vcs0
[551.035304] Dynamic subtest vcs0: FAIL (0.549s)
[551.053631] Starting dynamic subtest: vcs1
[552.601471] Dynamic subtest vcs1: FAIL (1.534s)
[552.612620] Starting dynamic subtest: vecs0
[554.569420] Dynamic subtest vecs0: FAIL (1.946s)
[554.579741] Starting dynamic subtest: ccs0
[556.561860] Dynamic subtest ccs0: FAIL (1.957s)
[556.563670] Subtest semaphore-busy: FAIL (8.177s)
[556.641938] [110/131] (468s left) kms_vrr (seamless-rr-switch-virtual)
[556.746643] Starting subtest: seamless-rr-switch-virtual
[556.754347] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[556.821132] [111/131] (468s left) kms_async_flips (async-flip-suspend-resume)
[556.918193] Starting subtest: async-flip-suspend-resume
[557.306457] Starting dynamic subtest: pipe-A-eDP-1
[575.050175] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.909s)
[575.428167] Starting dynamic subtest: pipe-B-eDP-1
[593.029806] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.776s)
[593.400745] Starting dynamic subtest: pipe-C-eDP-1
[611.032361] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s)
[611.394868] Starting dynamic subtest: pipe-D-eDP-1
[629.028085] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.824s)
[629.032969] Subtest async-flip-suspend-resume: SUCCESS (12.742s)
[630.295146] [112/131] (395s left) gem_fence_thrash (bo-write-verify-threaded-none)
[630.338638] Starting subtest: bo-write-verify-threaded-none
[630.360300] Subtest bo-write-verify-threaded-none: SKIP (0.020s)
[630.433329] [113/131] (395s left) kms_rmfb (rmfb-ioctl)
[630.537645] Starting subtest: rmfb-ioctl
[630.539933] Starting dynamic subtest: pipe-A-eDP-1
[630.645806] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[630.657432] Starting dynamic subtest: pipe-B-eDP-1
[631.890706] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.199s)
[631.902825] Starting dynamic subtest: pipe-C-eDP-1
[633.046531] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[633.060237] Starting dynamic subtest: pipe-D-eDP-1
[634.223308] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.144s)
[634.225954] Subtest rmfb-ioctl: SUCCESS (3.573s)
[635.498721] [114/131] (390s left) kms_psr (psr-cursor-blt)
[635.602613] Starting subtest: psr-cursor-blt
[635.605262] Starting dynamic subtest: eDP-1
[637.297877] Dynamic subtest eDP-1: SUCCESS (1.662s)
[637.300685] Subtest psr-cursor-blt: SUCCESS (1.663s)
[638.195094] [115/131] (387s left) kms_cursor_crc (cursor-offscreen-256x85)
[638.446395] Starting subtest: cursor-offscreen-256x85
[638.491879] Subtest cursor-offscreen-256x85: SKIP (0.039s)
[638.663225] [116/131] (387s left) gem_ctx_persistence (engines-mixed)
[638.724506] Starting subtest: engines-mixed
[638.727029] Starting dynamic subtest: rcs0
[638.839392] Dynamic subtest rcs0: SUCCESS (0.113s)
[638.852380] Starting dynamic subtest: bcs0
[638.913086] Dynamic subtest bcs0: SUCCESS (0.071s)
[638.925564] Starting dynamic subtest: vcs0
[638.996739] Dynamic subtest vcs0: SUCCESS (0.081s)
[639.007536] Starting dynamic subtest: vcs1
[639.064847] Dynamic subtest vcs1: SUCCESS (0.065s)
[639.077566] Starting dynamic subtest: vecs0
[639.133821] Dynamic subtest vecs0: SUCCESS (0.066s)
[639.145621] Starting dynamic subtest: ccs0
[639.206835] Dynamic subtest ccs0: SUCCESS (0.070s)
[639.209281] Subtest engines-mixed: SUCCESS (0.477s)
[639.306204] [117/131] (386s left) gem_exec_balancer (parallel-balancer)
[639.562776] Starting subtest: parallel-balancer
[640.480687] Subtest parallel-balancer: SUCCESS (0.907s)
[640.617408] [118/131] (385s left) sysfs_heartbeat_interval (nopreempt)
[640.685485] Starting subtest: nopreempt
[640.688160] Starting dynamic subtest: vecs0
[650.011527] Dynamic subtest vecs0: SUCCESS (9.262s)
[650.023683] Starting dynamic subtest: ccs0
[654.032693] Dynamic subtest ccs0: SUCCESS (4.010s)
[654.045863] Starting dynamic subtest: vcs0
[664.035821] Dynamic subtest vcs0: SUCCESS (9.984s)
[664.048088] Starting dynamic subtest: bcs0
[668.002684] Dynamic subtest bcs0: SUCCESS (3.964s)
[668.015542] Starting dynamic subtest: rcs0
[672.034275] Dynamic subtest rcs0: SUCCESS (4.026s)
[672.047428] Starting dynamic subtest: vcs1
[682.017462] Dynamic subtest vcs1: SUCCESS (9.974s)
[682.020336] Subtest nopreempt: SUCCESS (41.232s)
[682.109203] [119/131] (343s left) gem_ctx_shared (detached-shared-gtt)
[682.175611] Starting subtest: detached-shared-gtt
[684.333254] Subtest detached-shared-gtt: SUCCESS (2.155s)
[684.824087] [120/131] (341s left) kms_rotation_crc (bad-tiling)
[684.924827] Starting subtest: bad-tiling
[684.929640] Subtest bad-tiling: SKIP (0.001s)
[685.010726] [121/131] (340s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[685.062583] Starting subtest: invalid-bsd2-flag-on-vebox
[685.065307] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[685.188854] [122/131] (340s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[685.291959] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[685.297351] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[685.399488] [123/131] (340s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[685.494042] Starting subtest: fbc-rgb101010-draw-render
[690.130518] Subtest fbc-rgb101010-draw-render: SUCCESS (4.637s)
[691.313227] [124/131] (334s left) kms_addfb_basic (addfb25-bad-modifier)
[691.415115] Starting subtest: addfb25-bad-modifier
[691.417532] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[691.552058] [125/131] (334s left) gem_mmap_wc (write-prefaulted)
[691.616558] Subtest write-prefaulted: SKIP (0.000s)
[691.679717] [126/131] (334s left) kms_psr (pr-sprite-plane-onoff)
[691.761585] Starting subtest: pr-sprite-plane-onoff
[691.766612] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[691.848478] [127/131] (334s left) gem_close_race (multigpu-basic-process)
[691.922824] Starting subtest: multigpu-basic-process
[691.928237] Subtest multigpu-basic-process: SKIP (0.000s)
[692.192484] [128/131] (334s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[697.173821] Starting subtest: psr2-overlay-plane-move-continuous-sf
[697.176302] Starting dynamic subtest: pipe-A-eDP-1
[703.874949] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.696s)
[703.892227] Starting dynamic subtest: pipe-B-eDP-1
[710.608833] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.729s)
[710.611492] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.429s)
[711.497564] [129/131] (314s left) gem_wait (busy)
[711.566686] Starting subtest: busy
[711.569428] Starting dynamic subtest: all-engines
[712.971350] Dynamic subtest all-engines: SUCCESS (1.403s)
[712.984811] Starting dynamic subtest: rcs0
[713.512053] Dynamic subtest rcs0: SUCCESS (0.539s)
[713.524385] Starting dynamic subtest: bcs0
[714.052548] Dynamic subtest bcs0: SUCCESS (0.540s)
[714.062705] Starting dynamic subtest: vcs0
[715.981440] Dynamic subtest vcs0: SUCCESS (1.925s)
[715.993971] Starting dynamic subtest: vcs1
[717.962196] Dynamic subtest vcs1: SUCCESS (1.976s)
[717.975610] Starting dynamic subtest: vecs0
[720.011332] Dynamic subtest vecs0: SUCCESS (2.045s)
[720.024468] Starting dynamic subtest: ccs0
[720.554701] Dynamic subtest ccs0: SUCCESS (0.542s)
[720.557420] Subtest busy: SUCCESS (8.984s)
[720.810509] [130/131] (305s left) gem_exec_whisper (basic-queues-priority-all)
[720.886460] Starting subtest: basic-queues-priority-all
[743.302687] Subtest basic-queues-priority-all: SUCCESS (22.401s)
[743.516960] [131/131] (282s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[743.617851] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[743.620605] Starting dynamic subtest: pipe-A-eDP-1
[743.641837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[743.653414] Starting dynamic subtest: pipe-B-eDP-1
[743.674690] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[743.684854] Starting dynamic subtest: pipe-C-eDP-1
[743.706832] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[743.716954] Starting dynamic subtest: pipe-D-eDP-1
[743.738410] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[743.740876] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[745.882846] Closing watchdogs
results: parsing output: 0/ for test: gem_set_tiling_vs_blt
results: parsing output: 1/ for test: kms_force_connector_basic
results: parsing output: 2/ for test: kms_dsc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_spin_batch
results: parsing output: 5/ for test: kms_chamelium_audio
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: kms_plane_multiple
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_tiled_wc
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: fbdev
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_pm_rpm
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: api_intel_bb
results: parsing output: 26/ for test: gem_madvise
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_ctx_persistence
results: parsing output: 29/ for test: i915_drm_fdinfo
results: parsing output: 30/ for test: prime_vgem
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: i915_selftest
results: parsing output: 33/ for test: i915_drm_fdinfo
results: parsing output: 34/ for test: kms_pm_rpm
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: gem_render_copy
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: kms_chamelium_hpd
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: api_intel_bb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: gem_linear_blits
results: parsing output: 47/ for test: gem_pxp
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: core_getstats
results: parsing output: 52/ for test: kms_addfb_basic
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_exec_store
results: parsing output: 57/ for test: gem_sync
results: parsing output: 58/ for test: gem_readwrite
results: parsing output: 59/ for test: sw_sync
results: parsing output: 60/ for test: sriov_basic
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: gem_mmap_offset
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: kms_setmode
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_plane_scaling
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_lease
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_chamelium_edid
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: kms_multipipe_modeset
results: parsing output: 79/ for test: kms_invalid_mode
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_atomic_transition
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: vgem_basic
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_cursor_crc
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_basic
results: parsing output: 96/ for test: kms_concurrent
results: parsing output: 97/ for test: kms_sequence
results: parsing output: 98/ for test: kms_pm_backlight
results: parsing output: 99/ for test: kms_panel_fitting
results: parsing output: 100/ for test: gen9_exec_parse
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_feature_discovery
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: kms_vrr
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: gem_fence_thrash
results: parsing output: 112/ for test: kms_rmfb
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: gem_exec_balancer
results: parsing output: 117/ for test: sysfs_heartbeat_interval
results: parsing output: 118/ for test: gem_ctx_shared
results: parsing output: 119/ for test: kms_rotation_crc
results: parsing output: 120/ for test: gem_exec_params
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_addfb_basic
results: parsing output: 124/ for test: gem_mmap_wc
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: gem_close_race
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: gem_wait
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: kms_ccs
Done.