[56.287025] Initializing watchdogs
[56.287072]   /dev/watchdog0
[56.302132] [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]
[56.306673] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.309092] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.312550] [001/133] (960s left) gem_exec_schedule (u-semaphore-noskip)
[56.412665] Starting subtest: u-semaphore-noskip
[56.856913] Subtest u-semaphore-noskip: SUCCESS (0.445s)
[57.197771] [002/133] (959s left) i915_pm_rpm (system-suspend)
[60.169634] Starting subtest: system-suspend
[78.589067] Subtest system-suspend: SUCCESS (3.266s)
[88.037623] [003/133] (937s left) gem_mmap_gtt (basic)
[88.116762] Subtest basic: SKIP (0.000s)
[88.174497] [004/133] (937s left) gem_workarounds (suspend-resume)
[88.234217] Starting subtest: suspend-resume
[104.896374] Subtest suspend-resume: SUCCESS (2.365s)
[115.064938] [005/133] (921s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[115.166120] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[115.168308] Starting dynamic subtest: pipe-A-eDP-1
[115.177041] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[115.186673] Starting dynamic subtest: pipe-B-eDP-1
[115.196331] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[115.206910] Starting dynamic subtest: pipe-C-eDP-1
[115.215149] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[115.222539] Starting dynamic subtest: pipe-D-eDP-1
[115.230733] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[115.234841] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[117.382531] [006/133] (918s left) sw_sync (sync_busy_fork_unixsocket)
[117.421749] Starting subtest: sync_busy_fork_unixsocket
[117.430509] Subtest sync_busy_fork_unixsocket: SUCCESS (0.010s)
[117.479667] [007/133] (918s left) kms_vrr (seamless-rr-switch-vrr)
[117.575635] Starting subtest: seamless-rr-switch-vrr
[117.581931] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[117.662917] [008/133] (918s left) gem_exec_balancer (waits)
[117.721840] Starting subtest: waits
[124.310677] Subtest waits: SUCCESS (6.520s)
[124.582402] [009/133] (911s left) gem_exec_reloc (basic-gtt-noreloc)
[124.646787] Subtest basic-gtt-noreloc: SKIP (0.000s)
[124.719724] [010/133] (911s left) kms_psr (fbc-psr-suspend)
[124.825834] Starting subtest: fbc-psr-suspend
[124.828170] Starting dynamic subtest: eDP-1
[124.832495] Dynamic subtest eDP-1: SKIP (0.000s)
[124.837228] Subtest fbc-psr-suspend: SKIP (0.000s)
[124.896728] [011/133] (911s left) gem_pxp (reject-modify-context-protection-off-3)
[125.019730] Starting subtest: reject-modify-context-protection-off-3
[125.021938] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[125.137561] [012/133] (911s left) gem_exec_fence (syncobj-import)
[125.577559] Starting subtest: syncobj-import
[125.582117] Subtest syncobj-import: SUCCESS (0.004s)
[127.353591] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[127.357170] [013/133] (909s left) gem_exec_schedule (preemptive-hang)
[127.532797] Starting subtest: preemptive-hang
[127.535446] Starting dynamic subtest: rcs0
[136.439025] Dynamic subtest rcs0: SUCCESS (8.896s)
[136.458390] Starting dynamic subtest: bcs0
[145.459194] Dynamic subtest bcs0: SUCCESS (9.019s)
[145.472112] Starting dynamic subtest: vcs0
[154.484950] Dynamic subtest vcs0: SUCCESS (9.023s)
[154.498578] Starting dynamic subtest: vcs1
[163.446786] Dynamic subtest vcs1: SUCCESS (8.957s)
[163.461458] Starting dynamic subtest: vecs0
[172.469008] Dynamic subtest vecs0: SUCCESS (9.015s)
[172.476818] Starting dynamic subtest: ccs0
[181.429828] Dynamic subtest ccs0: SUCCESS (8.960s)
[181.432185] Subtest preemptive-hang: SUCCESS (53.873s)
[181.654644] [014/133] (854s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[181.755892] Starting subtest: fbc-psr2-cursor-mmap-gtt
[181.758182] Starting dynamic subtest: eDP-1
[181.762597] Dynamic subtest eDP-1: SKIP (0.000s)
[181.767094] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[181.840761] [015/133] (854s left) gem_eio (in-flight-internal-1us)
[182.031483] Starting subtest: in-flight-internal-1us
[183.360958] Subtest in-flight-internal-1us: SUCCESS (1.328s)
[183.491072] [016/133] (853s left) kms_psr (psr-primary-page-flip)
[183.578571] Starting subtest: psr-primary-page-flip
[183.580715] Starting dynamic subtest: eDP-1
[185.316678] Dynamic subtest eDP-1: SUCCESS (1.737s)
[185.319119] Subtest psr-primary-page-flip: SUCCESS (1.738s)
[186.178802] [017/133] (850s left) gem_exec_alignment (pi-isolated)
[186.249188] Starting subtest: pi-isolated
[238.939976] Subtest pi-isolated: SUCCESS (52.688s)
[239.943837] [018/133] (796s left) prime_self_import (export-vs-gem_close-race)
[240.022874] Starting subtest: export-vs-gem_close-race
[245.130017] Subtest export-vs-gem_close-race: SUCCESS (5.092s)
[245.214414] [019/133] (791s left) api_intel_bb (reset-bb)
[245.297950] Starting subtest: reset-bb
[245.304851] Subtest reset-bb: SUCCESS (0.008s)
[245.447604] [020/133] (791s left) syncobj_wait (multi-wait-submitted)
[245.515821] Starting subtest: multi-wait-submitted
[245.620552] Subtest multi-wait-submitted: SUCCESS (0.103s)
[245.700072] [021/133] (791s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[245.858216] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[247.037943] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.186s)
[247.163590] [022/133] (789s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[247.264778] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[254.622765] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.359s)
[254.746197] [023/133] (782s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[254.843609] Starting subtest: y-tiled-64bpp-rotate-0
[254.847785] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[254.945819] [024/133] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[255.041914] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[255.046104] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[255.143944] [025/133] (781s left) kms_dsc (dsc-with-formats)
[255.231940] Starting subtest: dsc-with-formats
[255.270757] Subtest dsc-with-formats: SKIP (0.001s)
[255.312436] [026/133] (781s left) perf_pmu (most-busy-check-all)
[255.352155] Starting subtest: most-busy-check-all
[255.354418] Starting dynamic subtest: rcs0
[257.354069] Dynamic subtest rcs0: SUCCESS (1.999s)
[257.365821] Starting dynamic subtest: bcs0
[259.338190] Dynamic subtest bcs0: SUCCESS (1.983s)
[259.349326] Starting dynamic subtest: vcs0
[261.321085] Dynamic subtest vcs0: SUCCESS (1.981s)
[261.333411] Starting dynamic subtest: vcs1
[263.306722] Dynamic subtest vcs1: SUCCESS (1.984s)
[263.319849] Starting dynamic subtest: vecs0
[265.353378] Dynamic subtest vecs0: SUCCESS (2.045s)
[265.366217] Starting dynamic subtest: ccs0
[267.337558] Dynamic subtest ccs0: SUCCESS (1.982s)
[267.340217] Subtest most-busy-check-all: SUCCESS (11.982s)
[267.461953] [027/133] (769s left) gem_mmap_gtt (medium-copy-odd)
[267.519248] Subtest medium-copy-odd: SKIP (0.000s)
[267.577931] [028/133] (769s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[267.677467] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[267.679780] Starting dynamic subtest: A-eDP1
[271.256963] Dynamic subtest A-eDP1: SUCCESS (3.577s)
[271.267408] Starting dynamic subtest: B-eDP1
[274.461598] Dynamic subtest B-eDP1: SUCCESS (3.204s)
[274.471541] Starting dynamic subtest: C-eDP1
[277.659142] Dynamic subtest C-eDP1: SUCCESS (3.195s)
[277.669189] Starting dynamic subtest: D-eDP1
[280.780837] Dynamic subtest D-eDP1: SUCCESS (3.122s)
[280.783158] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.103s)
[281.583652] [029/133] (755s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[281.656329] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[281.715310] [030/133] (755s left) kms_color (ctm-signed)
[281.813632] Starting subtest: ctm-signed
[281.815830] Starting dynamic subtest: pipe-A-eDP-1
[283.888373] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.073s)
[283.899120] Starting dynamic subtest: pipe-B-eDP-1
[286.728008] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.839s)
[286.737890] Starting dynamic subtest: pipe-C-eDP-1
[289.441358] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.711s)
[289.452234] Starting dynamic subtest: pipe-D-eDP-1
[292.112442] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.673s)
[292.114763] Subtest ctm-signed: SUCCESS (10.298s)
[292.924372] [031/133] (744s left) gem_softpin (safe-alignment)
[292.983523] Starting subtest: safe-alignment
[293.004600] Subtest safe-alignment: SUCCESS (0.021s)
[294.388059] [032/133] (742s left) gem_exec_whisper (basic-sync)
[294.449809] Starting subtest: basic-sync
[304.243855] Subtest basic-sync: SUCCESS (9.772s)
[304.411981] [033/133] (732s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[304.515818] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[304.518159] Starting dynamic subtest: pipe-A
[304.536211] Dynamic subtest pipe-A: SKIP (0.017s)
[304.546871] Starting dynamic subtest: pipe-B
[304.568114] Dynamic subtest pipe-B: SKIP (0.031s)
[304.577974] Starting dynamic subtest: pipe-C
[304.601378] Dynamic subtest pipe-C: SKIP (0.031s)
[304.610834] Starting dynamic subtest: pipe-D
[304.631495] Dynamic subtest pipe-D: SKIP (0.031s)
[304.635747] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.113s)
[304.745114] [034/133] (732s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[304.853756] Starting subtest: fbc-psr2-cursor-plane-update-sf
[304.856021] Starting dynamic subtest: pipe-A-eDP-1
[304.941185] Dynamic subtest pipe-A-eDP-1: SKIP (0.091s)
[304.958559] Starting dynamic subtest: pipe-B-eDP-1
[306.100863] Dynamic subtest pipe-B-eDP-1: SKIP (1.157s)
[306.104927] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.251s)
[307.291220] [035/133] (730s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[307.390515] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[308.502359] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.111s)
[308.590449] [036/133] (728s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[308.690231] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[308.693926] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[308.792936] [037/133] (728s left) gem_ringfill (legacy-basic)
[314.316301] Starting subtest: legacy-basic
[314.318928] Starting dynamic subtest: default
[314.375049] Dynamic subtest default: SUCCESS (0.059s)
[314.387192] Starting dynamic subtest: render
[314.416968] Dynamic subtest render: SUCCESS (0.040s)
[314.427547] Starting dynamic subtest: bsd
[314.460875] Dynamic subtest bsd: SUCCESS (0.041s)
[314.472971] Starting dynamic subtest: bsd1
[314.504331] Dynamic subtest bsd1: SUCCESS (0.042s)
[314.515503] Starting dynamic subtest: bsd2
[314.545261] Dynamic subtest bsd2: SUCCESS (0.039s)
[314.555454] Starting dynamic subtest: blt
[314.591646] Dynamic subtest blt: SUCCESS (0.044s)
[314.602878] Starting dynamic subtest: vebox
[314.633505] Dynamic subtest vebox: SUCCESS (0.040s)
[314.636334] Subtest legacy-basic: SUCCESS (0.319s)
[314.710588] [038/133] (722s left) gem_eio (wait-wedge-10ms)
[314.959284] Starting subtest: wait-wedge-10ms
[316.453969] Subtest wait-wedge-10ms: SUCCESS (1.493s)
[316.583066] [039/133] (720s left) kms_chamelium_frames (dp-crc-multiple)
[316.964336] Subtest dp-crc-multiple: SKIP (0.000s)
[317.823982] [040/133] (719s left) kms_cursor_legacy (single-bo)
[317.952595] Starting subtest: single-bo
[317.954793] Starting dynamic subtest: pipe-A
[323.390928] Dynamic subtest pipe-A: SUCCESS (5.378s)
[323.403407] Starting dynamic subtest: pipe-B
[328.772104] Dynamic subtest pipe-B: SUCCESS (5.380s)
[328.784801] Starting dynamic subtest: pipe-C
[334.155857] Dynamic subtest pipe-C: SUCCESS (5.381s)
[334.168038] Starting dynamic subtest: pipe-D
[339.536162] Dynamic subtest pipe-D: SUCCESS (5.380s)
[339.548204] Starting dynamic subtest: all-pipes
[344.923379] Dynamic subtest all-pipes: SUCCESS (5.388s)
[344.925504] Subtest single-bo: SUCCESS (26.916s)
[345.030058] [041/133] (692s left) kms_rmfb (rmfb-ioctl)
[345.130917] Starting subtest: rmfb-ioctl
[345.133191] Starting dynamic subtest: pipe-A-eDP-1
[345.236043] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[345.250894] Starting dynamic subtest: pipe-B-eDP-1
[346.470484] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.233s)
[346.482757] Starting dynamic subtest: pipe-C-eDP-1
[347.592456] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[347.602674] Starting dynamic subtest: pipe-D-eDP-1
[348.725191] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[348.727430] Subtest rmfb-ioctl: SUCCESS (3.597s)
[349.852766] [042/133] (687s left) i915_pm_rps (thresholds-idle)
[349.916693] Starting subtest: thresholds-idle
[349.921163] Subtest thresholds-idle: SKIP (0.001s)
[350.039168] [043/133] (687s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[350.134847] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[350.139377] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[350.208564] [044/133] (687s left) gem_userptr_blits (mmap-offset-banned)
[350.301428] Starting subtest: mmap-offset-banned
[350.303703] Starting dynamic subtest: wb
[350.305980] Dynamic subtest wb: SUCCESS (0.000s)
[350.318239] Starting dynamic subtest: wc
[350.320070] Dynamic subtest wc: SUCCESS (0.000s)
[350.329082] Starting dynamic subtest: uc
[350.331004] Dynamic subtest uc: SUCCESS (0.000s)
[350.332957] Subtest mmap-offset-banned: SUCCESS (0.002s)
[350.441544] [045/133] (687s left) gem_workarounds (reset-fd)
[350.509702] Starting subtest: reset-fd
[350.697068] Subtest reset-fd: SUCCESS (0.187s)
[350.828622] [046/133] (687s left) gem_ctx_persistence (heartbeat-many)
[350.892227] Starting subtest: heartbeat-many
[350.895955] Subtest heartbeat-many: SKIP (0.000s)
[350.996954] [047/133] (686s left) gem_exec_reloc (basic-wc)
[351.054567] Subtest basic-wc: SKIP (0.000s)
[351.142565] [048/133] (686s left) gem_mmap_offset (open-flood)
[351.203874] Starting subtest: open-flood
[372.687563] Subtest open-flood: SUCCESS (21.488s)
[372.805891] [049/133] (665s left) syncobj_wait (wait-any-snapshot)
[372.871410] Starting subtest: wait-any-snapshot
[372.953709] Subtest wait-any-snapshot: SUCCESS (0.081s)
[373.030702] [050/133] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[373.134856] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[373.138320] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[373.245467] [051/133] (664s left) prime_vgem (basic-fence-mmap)
[373.311758] Starting subtest: basic-fence-mmap
[373.315605] Subtest basic-fence-mmap: SKIP (0.000s)
[373.422978] [052/133] (664s left) dmabuf_sync_file (import-multiple-read-write)
[373.469983] Starting subtest: import-multiple-read-write
[373.471800] Subtest import-multiple-read-write: SUCCESS (0.003s)
[373.523953] [053/133] (664s left) syncobj_timeline (multi-wait-for-submit-signaled)
[373.579953] Starting subtest: multi-wait-for-submit-signaled
[373.582181] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[373.686839] [054/133] (664s left) syncobj_basic (bad-destroy-pad)
[373.743836] Starting subtest: bad-destroy-pad
[373.745630] Subtest bad-destroy-pad: SUCCESS (0.000s)
[373.846766] [055/133] (664s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[373.947278] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[373.949186] Starting dynamic subtest: pipe-A-eDP-1
[374.099817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s)
[374.111376] Starting dynamic subtest: pipe-B-eDP-1
[374.127527] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[374.139798] Starting dynamic subtest: pipe-C-eDP-1
[374.156398] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[374.168196] Starting dynamic subtest: pipe-D-eDP-1
[374.184487] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[374.186150] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.178s)
[376.413441] [056/133] (661s left) kms_atomic_interruptible (legacy-cursor)
[376.501026] Starting subtest: legacy-cursor
[376.503304] Starting dynamic subtest: pipe-A-eDP-1
[383.924862] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.424s)
[383.927055] Subtest legacy-cursor: SUCCESS (7.426s)
[384.769903] [057/133] (653s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[384.876545] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[384.880592] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[384.958061] [058/133] (653s left) kms_flip (2x-blocking-absolute-wf_vblank)
[385.062261] Starting subtest: 2x-blocking-absolute-wf_vblank
[385.073861] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[385.166181] [059/133] (653s left) kms_mmap_write_crc (main)
[385.268280] Starting subtest: main
[385.270631] Starting dynamic subtest: pipe-A-eDP-1
[388.866674] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.594s)
[388.868608] Subtest main: SUCCESS (3.597s)
[389.719344] [060/133] (648s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[389.789536] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[389.861462] [061/133] (648s left) syncobj_timeline (wait-delayed-signal)
[389.920768] Starting subtest: wait-delayed-signal
[390.021523] Subtest wait-delayed-signal: SUCCESS (0.102s)
[390.137429] [062/133] (648s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[390.234415] Starting subtest: stress-xrgb8888-ytiled
[390.238888] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[390.307344] [063/133] (648s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[390.391880] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[390.394147] Starting dynamic subtest: pipe-A-default-mode
[391.562526] Dynamic subtest pipe-A-default-mode: SKIP (1.169s)
[391.567066] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.171s)
[391.698521] [064/133] (646s left) kms_big_fb (linear-32bpp-rotate-0)
[391.800323] Starting subtest: linear-32bpp-rotate-0
[393.390799] Subtest linear-32bpp-rotate-0: SUCCESS (1.590s)
[393.538753] [065/133] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[393.635096] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[393.638609] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[393.734542] [066/133] (644s left) i915_drm_fdinfo (idle)
[393.782051] Starting subtest: idle
[393.783704] Starting dynamic subtest: rcs0
[394.342026] Dynamic subtest rcs0: SUCCESS (0.561s)
[394.354722] Starting dynamic subtest: bcs0
[394.848908] Dynamic subtest bcs0: SUCCESS (0.503s)
[394.862020] Starting dynamic subtest: vcs0
[395.354964] Dynamic subtest vcs0: SUCCESS (0.504s)
[395.367677] Starting dynamic subtest: vcs1
[395.860558] Dynamic subtest vcs1: SUCCESS (0.503s)
[395.872958] Starting dynamic subtest: vecs0
[396.366543] Dynamic subtest vecs0: SUCCESS (0.503s)
[396.379876] Starting dynamic subtest: ccs0
[396.872457] Dynamic subtest ccs0: SUCCESS (0.503s)
[396.875076] Subtest idle: SUCCESS (3.091s)
[396.954999] [067/133] (641s left) gem_exec_balancer (bonded-true-hang)
[397.231101] Starting subtest: bonded-true-hang
[397.236182] Subtest bonded-true-hang: SKIP (0.000s)
[397.330807] [068/133] (641s left) kms_invalid_mode (bad-hsync-start)
[397.431326] Starting subtest: bad-hsync-start
[397.433606] Starting dynamic subtest: pipe-A-eDP-1
[397.727883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[397.737952] Starting dynamic subtest: pipe-B-eDP-1
[397.740311] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[397.749898] Starting dynamic subtest: pipe-C-eDP-1
[397.752201] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[397.761676] Starting dynamic subtest: pipe-D-eDP-1
[397.764025] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[397.766293] Subtest bad-hsync-start: SUCCESS (0.303s)
[398.561000] [069/133] (640s left) i915_drm_fdinfo (virtual-busy-hang-all)
[398.607187] Starting subtest: virtual-busy-hang-all
[398.611688] Subtest virtual-busy-hang-all: SKIP (0.000s)
[398.667699] [070/133] (640s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[398.761472] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[407.417363] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.657s)
[407.525888] [071/133] (631s left) kms_vblank (query-forked-hang)
[407.620753] Starting subtest: query-forked-hang
[407.622961] Starting dynamic subtest: pipe-A-eDP-1
[434.129848] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.503s)
[434.145055] Starting dynamic subtest: pipe-D-eDP-1
[459.161169] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.021s)
[459.163498] Subtest query-forked-hang: SUCCESS (51.534s)
[460.045465] [072/133] (578s left) kms_atomic (crtc-invalid-params)
[460.137990] Starting subtest: crtc-invalid-params
[460.140320] Starting dynamic subtest: pipe-A-eDP-1
[460.505011] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s)
[460.507207] Subtest crtc-invalid-params: SUCCESS (0.368s)
[461.379006] [073/133] (577s left) gem_eio (in-flight-suspend)
[461.588901] Starting subtest: in-flight-suspend
[505.161741] Subtest in-flight-suspend: SUCCESS (14.179s)
[514.294690] [074/133] (533s left) kms_busy (extended-pageflip-hang-oldfb)
[514.419124] Starting subtest: extended-pageflip-hang-oldfb
[514.421333] Starting dynamic subtest: pipe-A
[514.825353] Dynamic subtest pipe-A: SUCCESS (0.407s)
[514.836664] Starting dynamic subtest: pipe-D
[515.990725] Dynamic subtest pipe-D: SUCCESS (1.160s)
[515.993036] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.571s)
[516.838102] [075/133] (531s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[516.940966] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[523.776614] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.829s)
[523.905773] [076/133] (524s left) kms_content_protection (suspend-resume)
[524.049565] Starting subtest: suspend-resume
[524.053787] Subtest suspend-resume: SKIP (0.000s)
[524.162739] [077/133] (524s left) kms_selftest (drm_damage_helper)
[524.204730] Starting subtest: drm_damage_helper
[524.212553] Starting dynamic subtest: drm_test_damage_iter_no_damage
[524.293973] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.082s)
[524.303843] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[524.389332] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.091s)
[524.400614] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[524.492328] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.100s)
[524.504505] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[524.591330] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.098s)
[524.602953] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[524.701655] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.111s)
[524.712291] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[524.799361] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.097s)
[524.810158] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[524.899487] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.099s)
[524.910528] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[524.986474] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.086s)
[524.997440] Starting dynamic subtest: drm_test_damage_iter_single_damage
[525.084557] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.097s)
[525.095515] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[525.170376] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.084s)
[525.180409] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[525.254785] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.084s)
[525.265230] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[525.349565] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.093s)
[525.360081] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[525.428581] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.079s)
[525.437767] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[525.528544] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.100s)
[525.540069] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[525.610631] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.081s)
[525.621667] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[525.702443] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.090s)
[525.713409] Starting dynamic subtest: drm_test_damage_iter_damage
[525.783835] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.080s)
[525.794197] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[525.858818] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.076s)
[525.868537] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[525.950498] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.089s)
[525.961100] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[526.031680] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.080s)
[526.043027] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[526.117769] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.085s)
[526.119726] Subtest drm_damage_helper: SUCCESS (1.913s)
[526.261033] [078/133] (521s left) syncobj_timeline (etime-single-wait-submitted)
[526.318179] Starting subtest: etime-single-wait-submitted
[526.425145] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[526.503098] [079/133] (521s left) kms_pm_rpm (legacy-planes)
[528.037762] Starting subtest: legacy-planes
[528.039971] Starting dynamic subtest: plane-64
[536.456652] Dynamic subtest plane-64: SUCCESS (8.410s)
[536.468421] Starting dynamic subtest: plane-94
[544.865078] Dynamic subtest plane-94: SUCCESS (8.398s)
[544.888303] Starting dynamic subtest: plane-124
[553.165584] Dynamic subtest plane-124: SUCCESS (8.292s)
[553.178140] Starting dynamic subtest: plane-134
[561.488104] Dynamic subtest plane-134: SUCCESS (8.314s)
[561.490613] Subtest legacy-planes: SUCCESS (33.424s)
[561.867372] [080/133] (486s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[561.966524] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[566.195262] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.230s)
[567.356409] [081/133] (480s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[567.408726] Starting subtest: invalid-single-wait-all-unsubmitted
[567.410648] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[567.509651] [082/133] (480s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[567.609750] Starting subtest: crc-primary-basic-y-tiled-ccs
[567.611866] Starting dynamic subtest: pipe-A-eDP-1
[567.633337] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[567.644726] Starting dynamic subtest: pipe-B-eDP-1
[567.665296] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[567.674990] Starting dynamic subtest: pipe-C-eDP-1
[567.696414] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[567.708410] Starting dynamic subtest: pipe-D-eDP-1
[567.730016] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[567.734085] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[569.909756] [083/133] (478s left) gem_ppgtt (shrink-vs-evict-pinned)
[569.960809] Starting subtest: shrink-vs-evict-pinned
[576.801608] Subtest shrink-vs-evict-pinned: SUCCESS (6.782s)
[576.857338] [084/133] (471s left) syncobj_wait (single-wait-all-submitted)
[576.918790] Starting subtest: single-wait-all-submitted
[577.024914] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[577.106632] [085/133] (471s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[577.211918] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[577.216510] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[577.314449] [086/133] (471s left) kms_flip_tiling (flip-change-tiling)
[577.430255] Starting subtest: flip-change-tiling
[577.432547] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[577.610601] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.178s)
[577.624514] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[577.744549] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[577.757932] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[577.878587] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[577.894836] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[578.021749] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[578.037718] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[578.166521] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[578.182536] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[578.358121] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.189s)
[578.370033] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[578.491611] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[578.504264] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[578.603406] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[578.616507] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[578.738145] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[578.751243] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[578.881489] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[578.893929] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[579.026054] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[579.039277] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[579.170054] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[579.183294] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[579.303983] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[579.317429] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[579.438652] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[579.452400] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[579.549009] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s)
[579.562971] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[579.693567] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[579.707255] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[579.837267] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[579.849623] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[579.981723] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[579.995205] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[580.126430] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[580.139426] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[580.271499] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[580.283659] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[580.415735] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[580.428850] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[580.537742] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[580.550098] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[580.682410] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[580.694896] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[580.826446] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[580.841686] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[580.970852] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[580.985887] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[581.115503] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[581.131005] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[581.260238] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[581.277790] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[581.404741] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[581.420269] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[581.538294] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.131s)
[581.551072] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[581.683248] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[581.696032] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[581.826925] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[581.842089] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[581.999085] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.168s)
[582.014345] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[582.144585] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[582.155959] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[582.288426] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[582.300513] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[582.433278] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[582.446414] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[582.555453] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[582.608189] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[583.918625] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.316s)
[583.932139] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[584.053030] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[584.066110] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[584.197424] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[584.210239] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[584.340944] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[584.354130] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[584.484774] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[584.499116] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[584.629737] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[584.644119] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[584.763027] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[584.775841] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[584.874499] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[584.886838] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[585.010122] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[585.023343] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[585.152820] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.141s)
[585.165817] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[585.296520] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[585.310045] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[585.441311] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[585.457420] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[585.575234] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[585.589092] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[585.721087] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s)
[585.732559] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[585.830816] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s)
[585.843254] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[585.987582] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.153s)
[586.000966] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[586.141659] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.153s)
[586.154881] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[586.297425] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.153s)
[586.310600] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[586.442369] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[586.455944] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[586.587928] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s)
[586.601019] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[586.731591] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.141s)
[586.744922] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[586.854236] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[586.867909] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[586.997127] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.141s)
[587.012369] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[587.142432] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[587.154000] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[587.286337] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[587.301638] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[587.431063] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[587.444568] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[587.575635] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[587.588671] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[587.720079] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[587.732699] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[587.842660] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[587.855752] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[587.987803] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[588.000811] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[588.131532] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[588.143963] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[588.276621] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[588.289121] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[588.420616] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[588.435737] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[588.565208] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[588.579689] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[588.710578] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.143s)
[588.723700] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[588.832509] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[588.886657] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[590.122608] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.242s)
[590.136119] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[590.222452] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[590.234907] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[590.322698] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[590.334969] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[590.433581] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[590.446161] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[590.544359] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[590.556821] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[590.655538] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[590.668231] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[590.755818] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[590.768813] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[590.858166] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[590.871008] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[590.956162] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[590.971712] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[591.067114] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[591.079172] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[591.177824] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[591.192178] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[591.288766] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.108s)
[591.300984] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[591.389116] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[591.401472] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[591.489621] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[591.502437] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[591.589565] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[591.602242] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[591.701043] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[591.712544] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[591.811492] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[591.826367] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[591.922612] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[591.934892] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[592.034248] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[592.046799] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[592.145792] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[592.158525] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[592.245496] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.097s)
[592.258028] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[592.356634] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[592.369286] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[592.467192] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[592.478461] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[592.578679] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[592.592309] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[592.689851] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.108s)
[592.702032] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[592.789922] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[592.802679] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[592.901202] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[592.913703] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[593.012299] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[593.024475] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[593.123583] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[593.136332] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[593.235209] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[593.247645] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[593.345841] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[593.360839] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[593.457181] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[593.472249] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[593.568253] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[593.580911] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[593.679410] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s)
[593.694201] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[593.802248] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.120s)
[593.815238] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[593.913180] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[593.954997] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[595.157211] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.209s)
[595.168431] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[595.268476] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[595.281112] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[595.379807] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[595.393136] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[595.491168] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[595.504168] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[595.601537] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.108s)
[595.616849] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[595.723710] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.118s)
[595.736046] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[595.835038] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s)
[595.848102] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[595.935558] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[595.949280] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[596.046194] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[596.060772] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[596.157245] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.108s)
[596.173861] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[596.268081] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.108s)
[596.281310] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[596.379716] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[596.391581] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[596.479522] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[596.494297] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[596.591122] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.109s)
[596.604205] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[596.702435] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s)
[596.717724] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[596.824876] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.120s)
[596.837532] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[596.935441] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[596.949729] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[597.046402] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[597.058777] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[597.158150] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[597.172161] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[597.308260] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.147s)
[597.321306] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[597.419263] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.108s)
[597.431593] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[597.541254] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.120s)
[597.554261] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[597.652289] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[597.665914] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[597.763477] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s)
[597.777913] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[597.874397] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[597.885766] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[597.985687] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[598.000467] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[598.085781] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.098s)
[598.096909] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[598.197064] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[598.209518] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[598.308865] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[598.321373] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[598.420075] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[598.432166] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[598.530552] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[598.543358] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[598.641827] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[598.654341] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[598.753037] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[598.765417] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[598.864080] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s)
[598.876349] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[598.986913] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.120s)
[599.003162] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[599.097954] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[599.130745] Subtest flip-change-tiling: SUCCESS (21.687s)
[600.354647] [087/133] (448s left) gem_exec_reloc (basic-write-gtt)
[600.409936] Subtest basic-write-gtt: SKIP (0.000s)
[600.485287] [088/133] (448s left) syncobj_timeline (single-wait-signaled)
[600.543246] Starting subtest: single-wait-signaled
[600.545489] Subtest single-wait-signaled: SUCCESS (0.000s)
[600.650082] [089/133] (448s left) dumb_buffer (map-valid)
[600.698354] Starting subtest: map-valid
[600.700574] Subtest map-valid: SUCCESS (0.000s)
[600.813498] [090/133] (447s left) kms_flip (modeset-vs-vblank-race)
[600.916859] Starting subtest: modeset-vs-vblank-race
[600.919195] Starting dynamic subtest: A-eDP1
[605.589846] Dynamic subtest A-eDP1: SUCCESS (4.668s)
[605.606053] Starting dynamic subtest: B-eDP1
[610.328326] Dynamic subtest B-eDP1: SUCCESS (4.733s)
[610.345278] Starting dynamic subtest: C-eDP1
[614.949803] Dynamic subtest C-eDP1: SUCCESS (4.616s)
[614.961956] Starting dynamic subtest: D-eDP1
[619.593924] Dynamic subtest D-eDP1: SUCCESS (4.640s)
[619.598792] Subtest modeset-vs-vblank-race: SUCCESS (18.670s)
[620.766093] [091/133] (428s left) gem_mmap_wc (fault-concurrent)
[620.821851] Subtest fault-concurrent: SKIP (0.000s)
[620.888130] [092/133] (427s left) gem_ctx_isolation (dirty-switch)
[620.953721] Starting subtest: dirty-switch
[620.955975] Starting dynamic subtest: rcs0
[621.146836] Dynamic subtest rcs0: SUCCESS (0.196s)
[621.160460] Starting dynamic subtest: bcs0
[621.345622] Dynamic subtest bcs0: SUCCESS (0.197s)
[621.355895] Starting dynamic subtest: vcs0
[621.554104] Dynamic subtest vcs0: SUCCESS (0.208s)
[621.565261] Starting dynamic subtest: vcs1
[622.926081] Dynamic subtest vcs1: SUCCESS (1.370s)
[622.936749] Starting dynamic subtest: vecs0
[624.936974] Dynamic subtest vecs0: SUCCESS (2.009s)
[624.949696] Starting dynamic subtest: ccs0
[626.927947] Dynamic subtest ccs0: SUCCESS (1.989s)
[626.930306] Subtest dirty-switch: SUCCESS (5.974s)
[627.178560] [093/133] (421s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[627.242816] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[627.344072] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[627.426299] [094/133] (421s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[627.531322] Starting subtest: fbc-rgb101010-draw-render
[632.192595] Subtest fbc-rgb101010-draw-render: SUCCESS (4.661s)
[633.372918] [095/133] (415s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[633.476065] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[633.478326] Starting dynamic subtest: pipe-A-eDP-1
[644.790113] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.309s)
[644.801002] Starting dynamic subtest: pipe-B-eDP-1
[656.795721] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.997s)
[656.797716] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.309s)
[657.650480] [096/133] (391s left) gem_exec_params (no-vebox)
[657.715245] Starting subtest: no-vebox
[657.717722] Subtest no-vebox: SUCCESS (0.002s)
[659.844620] [097/133] (389s left) kms_flip (2x-busy-flip)
[659.937576] Starting subtest: 2x-busy-flip
[659.949268] Subtest 2x-busy-flip: SKIP (0.011s)
[660.077368] [098/133] (389s left) syncobj_timeline (invalid-query-illegal-handle)
[660.129795] Starting subtest: invalid-query-illegal-handle
[660.132249] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[660.235784] [099/133] (388s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[660.328418] Starting subtest: addfb25-yf-tiled-legacy
[660.330697] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[660.451572] [100/133] (388s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[660.563035] Starting subtest: x-tiled-16bpp-rotate-270
[660.582940] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[660.699296] [101/133] (388s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[660.787887] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[660.791272] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[660.877716] [102/133] (388s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[660.958590] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[660.960529] Starting dynamic subtest: pipe-A-eDP-1
[660.979194] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[660.990519] Starting dynamic subtest: pipe-B-eDP-1
[661.008267] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[661.018273] Starting dynamic subtest: pipe-C-eDP-1
[661.035918] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[661.045434] Starting dynamic subtest: pipe-D-eDP-1
[661.063431] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[661.066741] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[663.117848] [103/133] (386s left) kms_rotation_crc (cursor-rotation-180)
[663.219944] Starting subtest: cursor-rotation-180
[664.697059] Subtest cursor-rotation-180: SUCCESS (1.477s)
[665.884166] [104/133] (383s left) kms_cursor_crc (cursor-onscreen-512x512)
[666.180166] Starting subtest: cursor-onscreen-512x512
[666.184713] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[666.339887] [105/133] (383s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[666.720484] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[667.492818] [106/133] (381s left) kms_psr (psr-cursor-plane-onoff)
[667.591172] Starting subtest: psr-cursor-plane-onoff
[667.594091] Starting dynamic subtest: eDP-1
[669.309366] Dynamic subtest eDP-1: SUCCESS (1.718s)
[669.311590] Subtest psr-cursor-plane-onoff: SUCCESS (1.719s)
[670.179611] [107/133] (379s left) kms_cursor_crc (cursor-random-128x128)
[670.395988] Starting subtest: cursor-random-128x128
[670.401173] Starting dynamic subtest: pipe-A-eDP-1
[673.742308] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.339s)
[673.772462] Starting dynamic subtest: pipe-D-eDP-1
[677.792140] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.026s)
[677.794470] Subtest cursor-random-128x128: SUCCESS (7.392s)
[678.669526] [108/133] (370s left) gem_exec_gttfill (engines)
[678.727059] Starting subtest: engines
[678.729358] Starting dynamic subtest: rcs0
[701.687361] Dynamic subtest rcs0: SUCCESS (22.947s)
[701.701539] Starting dynamic subtest: bcs0
[725.076235] Dynamic subtest bcs0: SUCCESS (23.375s)
[725.088914] Starting dynamic subtest: vcs0
[748.447013] Dynamic subtest vcs0: SUCCESS (23.356s)
[748.458176] Starting dynamic subtest: vcs1
[771.889156] Dynamic subtest vcs1: SUCCESS (23.427s)
[771.904769] Starting dynamic subtest: vecs0
[795.337742] Dynamic subtest vecs0: SUCCESS (23.435s)
[795.350607] Starting dynamic subtest: ccs0
[818.627053] Dynamic subtest ccs0: SUCCESS (23.278s)
[818.630048] Subtest engines: SUCCESS (139.832s)
[818.822323] [109/133] (230s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[818.979151] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[818.983294] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[819.076940] [110/133] (230s left) prime_busy (after-wait)
[819.139654] Starting subtest: after-wait
[819.145055] Starting dynamic subtest: rcs0
[819.170663] Dynamic subtest rcs0: SUCCESS (0.027s)
[819.182683] Starting dynamic subtest: bcs0
[819.210799] Dynamic subtest bcs0: SUCCESS (0.039s)
[819.221289] Starting dynamic subtest: vcs0
[819.250998] Dynamic subtest vcs0: SUCCESS (0.039s)
[819.261321] Starting dynamic subtest: vcs1
[819.291525] Dynamic subtest vcs1: SUCCESS (0.040s)
[819.302234] Starting dynamic subtest: vecs0
[819.330797] Dynamic subtest vecs0: SUCCESS (0.039s)
[819.340859] Starting dynamic subtest: ccs0
[819.371457] Dynamic subtest ccs0: SUCCESS (0.040s)
[819.480169] Subtest after-wait: SUCCESS (0.339s)
[819.571328] [111/133] (230s left) kms_cursor_edge_walk (256x256-top-bottom)
[819.676163] Starting subtest: 256x256-top-bottom
[819.678324] Starting dynamic subtest: pipe-A-eDP-1
[823.202755] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.525s)
[823.217488] Starting dynamic subtest: pipe-D-eDP-1
[826.415795] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.209s)
[826.417754] Subtest 256x256-top-bottom: SUCCESS (6.736s)
[827.220905] [112/133] (222s left) kms_plane_lowres (tiling-yf)
[827.324116] Starting subtest: tiling-yf
[827.328351] Subtest tiling-yf: SKIP (0.000s)
[827.402321] [113/133] (222s left) gem_lmem_swapping (verify-random-ccs)
[827.452825] Subtest verify-random-ccs: SKIP (0.000s)
[827.501065] [114/133] (222s left) kms_psr (fbc-psr-sprite-plane-move)
[827.603280] Starting subtest: fbc-psr-sprite-plane-move
[827.605463] Starting dynamic subtest: eDP-1
[827.609380] Dynamic subtest eDP-1: SKIP (0.000s)
[827.613424] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[827.677623] [115/133] (222s left) prime_vgem (basic-fence-read)
[827.762548] Starting subtest: basic-fence-read
[827.781563] Subtest basic-fence-read: SKIP (0.017s)
[827.911657] [116/133] (221s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[828.008175] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[828.012654] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[828.082178] [117/133] (221s left) api_intel_bb (add-remove-objects)
[828.137790] Starting subtest: add-remove-objects
[828.142383] Subtest add-remove-objects: SUCCESS (0.006s)
[828.268099] [118/133] (221s left) gem_exec_schedule (u-submit-golden-slice)
[828.345008] Starting subtest: u-submit-golden-slice
[828.347099] Starting dynamic subtest: rcs0
[828.381862] Dynamic subtest rcs0: SUCCESS (0.038s)
[828.392524] Starting dynamic subtest: bcs0
[828.420412] Dynamic subtest bcs0: SUCCESS (0.038s)
[828.430532] Starting dynamic subtest: vcs0
[828.455535] Dynamic subtest vcs0: SUCCESS (0.034s)
[828.468054] Starting dynamic subtest: vcs1
[828.490452] Dynamic subtest vcs1: SUCCESS (0.034s)
[828.500538] Starting dynamic subtest: vecs0
[828.526801] Dynamic subtest vecs0: SUCCESS (0.036s)
[828.537059] Starting dynamic subtest: ccs0
[828.563112] Dynamic subtest ccs0: SUCCESS (0.036s)
[828.565122] Subtest u-submit-golden-slice: SUCCESS (0.220s)
[829.818624] [119/133] (220s left) gem_create (create-size-update)
[829.878497] Starting subtest: create-size-update
[829.880959] Subtest create-size-update: SUCCESS (0.000s)
[830.091969] [120/133] (219s left) kms_cdclk (mode-transition-all-outputs)
[830.188633] Starting subtest: mode-transition-all-outputs
[830.490273] Subtest mode-transition-all-outputs: SKIP (0.299s)
[831.357435] [121/133] (218s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[831.455928] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[831.460311] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[831.558763] [122/133] (218s left) gem_pipe_control_store_loop (reused-buffer)
[831.634434] Starting subtest: reused-buffer
[833.787764] Subtest reused-buffer: SUCCESS (2.153s)
[833.918691] [123/133] (216s left) vgem_basic (create)
[833.960251] Starting subtest: create
[833.962892] Subtest create: SUCCESS (0.000s)
[834.023193] [124/133] (216s left) gem_fence_thrash (bo-write-verify-none)
[834.053625] Starting subtest: bo-write-verify-none
[834.076978] Subtest bo-write-verify-none: SKIP (0.019s)
[834.135453] [125/133] (216s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[834.260723] Starting subtest: basic-busy-flip-before-cursor-legacy
[834.265254] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[834.407765] [126/133] (215s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[834.508951] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[841.201307] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.691s)
[841.318423] [127/133] (209s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[841.443536] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[841.447960] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[841.594407] [128/133] (208s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[841.689254] Starting subtest: plane-scaler-unity-scaling-with-rotation
[841.691568] Starting dynamic subtest: pipe-A
[841.916571] Dynamic subtest pipe-A: SUCCESS (0.229s)
[841.927297] Starting dynamic subtest: pipe-B
[843.182523] Dynamic subtest pipe-B: SUCCESS (1.264s)
[843.192979] Starting dynamic subtest: pipe-C
[844.526322] Dynamic subtest pipe-C: SUCCESS (1.342s)
[844.538729] Starting dynamic subtest: pipe-D
[845.836608] Dynamic subtest pipe-D: SUCCESS (1.309s)
[845.839007] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.148s)
[847.024336] [129/133] (203s left) kms_pm_dc (dc6-psr)
[848.137130] Starting subtest: dc6-psr
[851.022747] Subtest dc6-psr: SUCCESS (2.884s)
[851.857027] [130/133] (198s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[851.952924] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[851.957459] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[852.036640] [131/133] (198s left) gen9_exec_parse (basic-rejected-ctx-param)
[852.099090] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[852.171239] [132/133] (198s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[852.268078] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[852.272186] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[852.367699] [133/133] (198s left) kms_fbcon_fbt (fbc-suspend)
[852.424597] Starting subtest: fbc-suspend
[901.964279] Subtest fbc-suspend: SUCCESS (19.835s)
[910.317618] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: i915_pm_rpm
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: gem_workarounds
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: sw_sync
results: parsing output: 6/ for test: kms_vrr
results: parsing output: 7/ for test: gem_exec_balancer
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: gem_exec_alignment
results: parsing output: 17/ for test: prime_self_import
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: syncobj_wait
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_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_dsc
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: gem_mmap_gtt
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_pipe_b_c_ivb
results: parsing output: 29/ for test: kms_color
results: parsing output: 30/ for test: gem_softpin
results: parsing output: 31/ for test: gem_exec_whisper
results: parsing output: 32/ for test: kms_plane_scaling
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_ringfill
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: kms_chamelium_frames
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_rmfb
results: parsing output: 41/ for test: i915_pm_rps
results: parsing output: 42/ for test: kms_plane
results: parsing output: 43/ for test: gem_userptr_blits
results: parsing output: 44/ for test: gem_workarounds
results: parsing output: 45/ for test: gem_ctx_persistence
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: gem_mmap_offset
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: prime_vgem
results: parsing output: 51/ for test: dmabuf_sync_file
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: syncobj_basic
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: kms_atomic_interruptible
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_mmap_write_crc
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_pipe_stress
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_invalid_mode
results: parsing output: 68/ for test: i915_drm_fdinfo
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_vblank
results: parsing output: 71/ for test: kms_atomic
results: parsing output: 72/ for test: gem_eio
results: parsing output: 73/ for test: kms_busy
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_content_protection
results: parsing output: 76/ for test: kms_selftest
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_pm_rpm
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: gem_ppgtt
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_flip_tiling
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: dumb_buffer
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_mmap_wc
results: parsing output: 91/ for test: gem_ctx_isolation
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: gem_exec_gttfill
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: prime_busy
results: parsing output: 110/ for test: kms_cursor_edge_walk
results: parsing output: 111/ for test: kms_plane_lowres
results: parsing output: 112/ for test: gem_lmem_swapping
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: prime_vgem
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: gem_create
results: parsing output: 119/ for test: kms_cdclk
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_pipe_control_store_loop
results: parsing output: 122/ for test: vgem_basic
results: parsing output: 123/ for test: gem_fence_thrash
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: kms_pm_dc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gen9_exec_parse
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_fbcon_fbt
Done.