[57.178212] Initializing watchdogs
[57.178261]   /dev/watchdog0
[57.195292] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.199604] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.201785] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.205192] [001/133] (960s left) gem_exec_schedule (u-semaphore-noskip)
[57.303507] Starting subtest: u-semaphore-noskip
[57.740799] Subtest u-semaphore-noskip: SUCCESS (0.441s)
[58.102275] [002/133] (959s left) i915_pm_rpm (system-suspend)
[60.064231] Starting subtest: system-suspend
[78.195504] Subtest system-suspend: SUCCESS (3.007s)
[78.588174] [003/133] (939s left) gem_mmap_gtt (basic)
[78.654536] Subtest basic: SKIP (0.000s)
[78.710525] [004/133] (939s left) gem_workarounds (suspend-resume)
[78.785364] Starting subtest: suspend-resume
[94.403424] Subtest suspend-resume: SUCCESS (1.855s)
[94.532824] [005/133] (923s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[94.630645] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[94.633355] Starting dynamic subtest: pipe-A-eDP-1
[94.643277] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[94.652586] Starting dynamic subtest: pipe-B-eDP-1
[94.662566] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[94.670610] Starting dynamic subtest: pipe-C-eDP-1
[94.680576] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[94.688744] Starting dynamic subtest: pipe-D-eDP-1
[94.699323] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[94.704457] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[96.886050] [006/133] (921s left) sw_sync (sync_busy_fork_unixsocket)
[96.928731] Starting subtest: sync_busy_fork_unixsocket
[96.936923] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[96.999705] [007/133] (920s left) kms_vrr (seamless-rr-switch-vrr)
[97.095568] Starting subtest: seamless-rr-switch-vrr
[97.103894] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[97.170128] [008/133] (920s left) gem_exec_balancer (waits)
[97.224653] Starting subtest: waits
[103.799850] Subtest waits: SUCCESS (6.470s)
[104.090782] [009/133] (913s left) gem_exec_reloc (basic-gtt-noreloc)
[104.149702] Subtest basic-gtt-noreloc: SKIP (0.000s)
[104.216370] [010/133] (913s left) kms_psr (fbc-psr-suspend)
[104.312438] Starting subtest: fbc-psr-suspend
[104.314963] Starting dynamic subtest: eDP-1
[104.320324] Dynamic subtest eDP-1: SKIP (0.000s)
[104.325586] Subtest fbc-psr-suspend: SKIP (0.000s)
[104.384245] [011/133] (913s left) gem_pxp (reject-modify-context-protection-off-3)
[104.527564] Starting subtest: reject-modify-context-protection-off-3
[104.530656] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[104.643479] [012/133] (913s left) gem_exec_fence (syncobj-import)
[105.084958] Starting subtest: syncobj-import
[105.092574] Subtest syncobj-import: SUCCESS (0.007s)
[106.803182] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[106.806736] [013/133] (911s left) gem_exec_schedule (preemptive-hang)
[106.986517] Starting subtest: preemptive-hang
[106.988626] Starting dynamic subtest: rcs0
[115.857740] Dynamic subtest rcs0: SUCCESS (8.836s)
[115.868698] Starting dynamic subtest: bcs0
[124.819086] Dynamic subtest bcs0: SUCCESS (8.945s)
[124.831908] Starting dynamic subtest: vcs0
[133.837078] Dynamic subtest vcs0: SUCCESS (9.020s)
[133.845534] Starting dynamic subtest: vcs1
[142.865174] Dynamic subtest vcs1: SUCCESS (9.027s)
[142.876402] Starting dynamic subtest: vecs0
[151.816824] Dynamic subtest vecs0: SUCCESS (8.950s)
[151.827396] Starting dynamic subtest: ccs0
[160.911808] Dynamic subtest ccs0: SUCCESS (9.092s)
[160.914801] Subtest preemptive-hang: SUCCESS (53.874s)
[161.148581] [014/133] (857s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[161.252117] Starting subtest: fbc-psr2-cursor-mmap-gtt
[161.254615] Starting dynamic subtest: eDP-1
[161.259821] Dynamic subtest eDP-1: SKIP (0.000s)
[161.265299] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[161.324472] [015/133] (856s left) gem_eio (in-flight-internal-1us)
[161.509608] Starting subtest: in-flight-internal-1us
[162.782845] Subtest in-flight-internal-1us: SUCCESS (1.273s)
[162.914938] [016/133] (855s left) kms_psr (psr-primary-page-flip)
[163.021364] Starting subtest: psr-primary-page-flip
[163.023977] Starting dynamic subtest: eDP-1
[164.768619] Dynamic subtest eDP-1: SUCCESS (1.747s)
[164.771618] Subtest psr-primary-page-flip: SUCCESS (1.748s)
[165.613913] [017/133] (852s left) gem_exec_alignment (pi-isolated)
[165.673814] Starting subtest: pi-isolated
[215.474798] Subtest pi-isolated: SUCCESS (49.794s)
[216.581821] [018/133] (801s left) prime_self_import (export-vs-gem_close-race)
[216.668702] Starting subtest: export-vs-gem_close-race
[221.753955] Subtest export-vs-gem_close-race: SUCCESS (5.087s)
[221.830777] [019/133] (796s left) api_intel_bb (reset-bb)
[221.893954] Starting subtest: reset-bb
[221.899466] Subtest reset-bb: SUCCESS (0.006s)
[222.042430] [020/133] (796s left) syncobj_wait (multi-wait-submitted)
[222.119658] Starting subtest: multi-wait-submitted
[222.226368] Subtest multi-wait-submitted: SUCCESS (0.105s)
[222.305643] [021/133] (796s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[222.435192] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[223.554544] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.119s)
[223.679056] [022/133] (794s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[223.771641] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[231.089785] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.321s)
[231.217416] [023/133] (787s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[231.320579] Starting subtest: y-tiled-64bpp-rotate-0
[231.325579] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[231.418494] [024/133] (787s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[231.513444] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[231.518554] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[231.614260] [025/133] (787s left) kms_dsc (dsc-with-formats)
[231.698832] Starting subtest: dsc-with-formats
[231.745414] Subtest dsc-with-formats: SKIP (0.002s)
[231.784795] [026/133] (786s left) perf_pmu (most-busy-check-all)
[231.836814] Starting subtest: most-busy-check-all
[231.839341] Starting dynamic subtest: rcs0
[233.703651] Dynamic subtest rcs0: SUCCESS (1.867s)
[233.714653] Starting dynamic subtest: bcs0
[235.687551] Dynamic subtest bcs0: SUCCESS (1.982s)
[235.700647] Starting dynamic subtest: vcs0
[237.736815] Dynamic subtest vcs0: SUCCESS (2.048s)
[237.749130] Starting dynamic subtest: vcs1
[239.718627] Dynamic subtest vcs1: SUCCESS (1.981s)
[239.731672] Starting dynamic subtest: vecs0
[241.703540] Dynamic subtest vecs0: SUCCESS (1.983s)
[241.716522] Starting dynamic subtest: ccs0
[243.750967] Dynamic subtest ccs0: SUCCESS (2.046s)
[243.753810] Subtest most-busy-check-all: SUCCESS (11.914s)
[243.853661] [027/133] (774s left) gem_mmap_gtt (medium-copy-odd)
[243.920352] Subtest medium-copy-odd: SKIP (0.000s)
[243.981738] [028/133] (774s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[244.085507] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[244.088460] Starting dynamic subtest: A-eDP1
[247.702266] Dynamic subtest A-eDP1: SUCCESS (3.619s)
[247.711622] Starting dynamic subtest: B-eDP1
[250.912858] Dynamic subtest B-eDP1: SUCCESS (3.208s)
[250.924620] Starting dynamic subtest: C-eDP1
[254.043495] Dynamic subtest C-eDP1: SUCCESS (3.130s)
[254.054582] Starting dynamic subtest: D-eDP1
[257.140587] Dynamic subtest D-eDP1: SUCCESS (3.096s)
[257.142778] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.057s)
[257.933724] [029/133] (760s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[257.993611] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[258.057476] [030/133] (760s left) kms_color (ctm-signed)
[258.160427] Starting subtest: ctm-signed
[258.162844] Starting dynamic subtest: pipe-A-eDP-1
[260.245745] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.085s)
[260.257006] Starting dynamic subtest: pipe-B-eDP-1
[263.062845] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.818s)
[263.073860] Starting dynamic subtest: pipe-C-eDP-1
[265.721830] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.657s)
[265.732521] Starting dynamic subtest: pipe-D-eDP-1
[268.401634] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.679s)
[268.404709] Subtest ctm-signed: SUCCESS (10.242s)
[269.237046] [031/133] (749s left) gem_softpin (safe-alignment)
[269.305254] Starting subtest: safe-alignment
[269.327341] Subtest safe-alignment: SUCCESS (0.022s)
[270.739327] [032/133] (748s left) gem_exec_whisper (basic-sync)
[270.804639] Starting subtest: basic-sync
[282.528860] Subtest basic-sync: SUCCESS (11.722s)
[282.714355] [033/133] (736s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[282.814762] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[282.817641] Starting dynamic subtest: pipe-A
[282.837829] Dynamic subtest pipe-A: SKIP (0.017s)
[282.853946] Starting dynamic subtest: pipe-B
[282.869287] Dynamic subtest pipe-B: SKIP (0.033s)
[282.880778] Starting dynamic subtest: pipe-C
[282.896567] Dynamic subtest pipe-C: SKIP (0.028s)
[282.906604] Starting dynamic subtest: pipe-D
[282.927370] Dynamic subtest pipe-D: SKIP (0.028s)
[282.932218] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.109s)
[283.030402] [034/133] (736s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[283.124684] Starting subtest: fbc-psr2-cursor-plane-update-sf
[283.127304] Starting dynamic subtest: pipe-A-eDP-1
[283.197538] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[283.207546] Starting dynamic subtest: pipe-B-eDP-1
[284.320958] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[284.326061] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.201s)
[285.506281] [035/133] (733s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[285.617432] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[286.606591] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.989s)
[286.725237] [036/133] (732s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[286.825292] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[286.829519] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[286.923552] [037/133] (732s left) gem_ringfill (legacy-basic)
[292.713854] Starting subtest: legacy-basic
[292.716702] Starting dynamic subtest: default
[292.771962] Dynamic subtest default: SUCCESS (0.057s)
[292.781888] Starting dynamic subtest: render
[292.815339] Dynamic subtest render: SUCCESS (0.040s)
[292.826153] Starting dynamic subtest: bsd
[292.861442] Dynamic subtest bsd: SUCCESS (0.043s)
[292.873683] Starting dynamic subtest: bsd1
[292.906979] Dynamic subtest bsd1: SUCCESS (0.043s)
[292.917871] Starting dynamic subtest: bsd2
[292.948050] Dynamic subtest bsd2: SUCCESS (0.039s)
[292.959586] Starting dynamic subtest: blt
[292.995220] Dynamic subtest blt: SUCCESS (0.045s)
[293.006461] Starting dynamic subtest: vebox
[293.040799] Dynamic subtest vebox: SUCCESS (0.044s)
[293.043486] Subtest legacy-basic: SUCCESS (0.328s)
[293.129621] [038/133] (726s left) gem_eio (wait-wedge-10ms)
[293.397562] Starting subtest: wait-wedge-10ms
[294.789408] Subtest wait-wedge-10ms: SUCCESS (1.390s)
[294.949289] [039/133] (724s left) kms_chamelium_frames (dp-crc-multiple)
[295.325821] Subtest dp-crc-multiple: SKIP (0.000s)
[296.116336] [040/133] (723s left) kms_cursor_legacy (single-bo)
[296.234370] Starting subtest: single-bo
[296.236593] Starting dynamic subtest: pipe-A
[301.616740] Dynamic subtest pipe-A: SUCCESS (5.379s)
[301.627804] Starting dynamic subtest: pipe-B
[307.001495] Dynamic subtest pipe-B: SUCCESS (5.381s)
[307.011703] Starting dynamic subtest: pipe-C
[312.385621] Dynamic subtest pipe-C: SUCCESS (5.380s)
[312.395707] Starting dynamic subtest: pipe-D
[317.769803] Dynamic subtest pipe-D: SUCCESS (5.380s)
[317.780862] Starting dynamic subtest: all-pipes
[323.158227] Dynamic subtest all-pipes: SUCCESS (5.388s)
[323.160984] Subtest single-bo: SUCCESS (26.918s)
[323.304153] [041/133] (696s left) kms_rmfb (rmfb-ioctl)
[323.391174] Starting subtest: rmfb-ioctl
[323.393681] Starting dynamic subtest: pipe-A-eDP-1
[323.498195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[323.509940] Starting dynamic subtest: pipe-B-eDP-1
[324.689962] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.190s)
[324.701066] Starting dynamic subtest: pipe-C-eDP-1
[325.815725] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[325.826446] Starting dynamic subtest: pipe-D-eDP-1
[326.937378] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[326.939793] Subtest rmfb-ioctl: SUCCESS (3.548s)
[328.146720] [042/133] (691s left) i915_pm_rps (thresholds-idle)
[328.203906] Starting subtest: thresholds-idle
[328.208654] Subtest thresholds-idle: SKIP (0.001s)
[328.317770] [043/133] (691s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[328.408781] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[328.413656] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[328.480110] [044/133] (691s left) gem_userptr_blits (mmap-offset-banned)
[328.545495] Starting subtest: mmap-offset-banned
[328.547513] Starting dynamic subtest: wb
[328.549533] Dynamic subtest wb: SUCCESS (0.000s)
[328.560318] Starting dynamic subtest: wc
[328.562814] Dynamic subtest wc: SUCCESS (0.000s)
[328.572661] Starting dynamic subtest: uc
[328.575519] Dynamic subtest uc: SUCCESS (0.000s)
[328.578242] Subtest mmap-offset-banned: SUCCESS (0.002s)
[328.674366] [045/133] (690s left) gem_workarounds (reset-fd)
[328.747609] Starting subtest: reset-fd
[328.934766] Subtest reset-fd: SUCCESS (0.184s)
[329.050336] [046/133] (690s left) gem_ctx_persistence (heartbeat-many)
[329.116343] Starting subtest: heartbeat-many
[329.120472] Subtest heartbeat-many: SKIP (0.000s)
[329.218020] [047/133] (690s left) gem_exec_reloc (basic-wc)
[329.277405] Subtest basic-wc: SKIP (0.000s)
[329.346123] [048/133] (690s left) gem_mmap_offset (open-flood)
[329.407779] Starting subtest: open-flood
[350.900531] Subtest open-flood: SUCCESS (21.496s)
[351.013521] [049/133] (668s left) syncobj_wait (wait-any-snapshot)
[351.073824] Starting subtest: wait-any-snapshot
[351.154154] Subtest wait-any-snapshot: SUCCESS (0.082s)
[351.251385] [050/133] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[351.357621] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[351.361786] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[351.456290] [051/133] (668s left) prime_vgem (basic-fence-mmap)
[351.520352] Starting subtest: basic-fence-mmap
[351.524838] Subtest basic-fence-mmap: SKIP (0.000s)
[351.614627] [052/133] (668s left) dmabuf_sync_file (import-multiple-read-write)
[351.661360] Starting subtest: import-multiple-read-write
[351.663550] Subtest import-multiple-read-write: SUCCESS (0.003s)
[351.721688] [053/133] (668s left) syncobj_timeline (multi-wait-for-submit-signaled)
[351.772515] Starting subtest: multi-wait-for-submit-signaled
[351.774591] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[351.869411] [054/133] (668s left) syncobj_basic (bad-destroy-pad)
[351.916571] Starting subtest: bad-destroy-pad
[351.918716] Subtest bad-destroy-pad: SUCCESS (0.000s)
[352.003901] [055/133] (667s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[352.101033] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[352.103037] Starting dynamic subtest: pipe-A-eDP-1
[352.247921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[352.258838] Starting dynamic subtest: pipe-B-eDP-1
[352.280158] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[352.292504] Starting dynamic subtest: pipe-C-eDP-1
[352.310138] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[352.319100] Starting dynamic subtest: pipe-D-eDP-1
[352.336324] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[352.337948] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.178s)
[354.513197] [056/133] (665s left) kms_atomic_interruptible (legacy-cursor)
[354.602746] Starting subtest: legacy-cursor
[354.605545] Starting dynamic subtest: pipe-A-eDP-1
[362.020597] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.415s)
[362.023264] Subtest legacy-cursor: SUCCESS (7.417s)
[362.858063] [057/133] (657s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[362.966408] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[362.971370] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[363.049910] [058/133] (657s left) kms_flip (2x-blocking-absolute-wf_vblank)
[363.140604] Starting subtest: 2x-blocking-absolute-wf_vblank
[363.151445] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[363.230049] [059/133] (656s left) kms_mmap_write_crc (main)
[363.321812] Starting subtest: main
[363.324523] Starting dynamic subtest: pipe-A-eDP-1
[366.684939] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.360s)
[366.687807] Subtest main: SUCCESS (3.361s)
[367.498648] [060/133] (652s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[367.563651] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[367.646309] [061/133] (652s left) syncobj_timeline (wait-delayed-signal)
[367.696455] Starting subtest: wait-delayed-signal
[367.797797] Subtest wait-delayed-signal: SUCCESS (0.102s)
[367.889735] [062/133] (652s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[367.986608] Starting subtest: stress-xrgb8888-ytiled
[367.991608] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[368.062515] [063/133] (652s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[368.151603] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[368.154681] Starting dynamic subtest: pipe-A-default-mode
[369.361606] Dynamic subtest pipe-A-default-mode: SKIP (1.208s)
[369.366592] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.209s)
[369.492524] [064/133] (650s left) kms_big_fb (linear-32bpp-rotate-0)
[369.590557] Starting subtest: linear-32bpp-rotate-0
[371.102728] Subtest linear-32bpp-rotate-0: SUCCESS (1.512s)
[371.223132] [065/133] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[371.314495] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[371.319070] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[371.416170] [066/133] (649s left) i915_drm_fdinfo (idle)
[371.456707] Starting subtest: idle
[371.459262] Starting dynamic subtest: rcs0
[372.019563] Dynamic subtest rcs0: SUCCESS (0.564s)
[372.031508] Starting dynamic subtest: bcs0
[372.526843] Dynamic subtest bcs0: SUCCESS (0.504s)
[372.539738] Starting dynamic subtest: vcs0
[373.032595] Dynamic subtest vcs0: SUCCESS (0.503s)
[373.043482] Starting dynamic subtest: vcs1
[373.538558] Dynamic subtest vcs1: SUCCESS (0.503s)
[373.549957] Starting dynamic subtest: vecs0
[374.044175] Dynamic subtest vecs0: SUCCESS (0.503s)
[374.055701] Starting dynamic subtest: ccs0
[374.549636] Dynamic subtest ccs0: SUCCESS (0.503s)
[374.552797] Subtest idle: SUCCESS (3.095s)
[374.629001] [067/133] (645s left) gem_exec_balancer (bonded-true-hang)
[374.938964] Starting subtest: bonded-true-hang
[374.944296] Subtest bonded-true-hang: SKIP (0.000s)
[375.051160] [068/133] (645s left) kms_invalid_mode (bad-hsync-start)
[375.154561] Starting subtest: bad-hsync-start
[375.157340] Starting dynamic subtest: pipe-A-eDP-1
[375.446724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[375.458315] Starting dynamic subtest: pipe-B-eDP-1
[375.460950] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[375.473969] Starting dynamic subtest: pipe-C-eDP-1
[375.476804] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[375.486674] Starting dynamic subtest: pipe-D-eDP-1
[375.489159] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[375.491432] Subtest bad-hsync-start: SUCCESS (0.308s)
[376.257042] [069/133] (644s left) i915_drm_fdinfo (virtual-busy-hang-all)
[376.312703] Starting subtest: virtual-busy-hang-all
[376.318614] Subtest virtual-busy-hang-all: SKIP (0.000s)
[376.393098] [070/133] (644s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[376.488802] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[385.050340] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.565s)
[385.141959] [071/133] (635s left) kms_vblank (query-forked-hang)
[385.232095] Starting subtest: query-forked-hang
[385.234579] Starting dynamic subtest: pipe-A-eDP-1
[412.460746] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.225s)
[412.477947] Starting dynamic subtest: pipe-D-eDP-1
[427.551115] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.085s)
[427.554078] Subtest query-forked-hang: SUCCESS (42.314s)
[428.405165] [072/133] (592s left) kms_atomic (crtc-invalid-params)
[428.500464] Starting subtest: crtc-invalid-params
[428.503279] Starting dynamic subtest: pipe-A-eDP-1
[428.862778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.360s)
[428.865292] Subtest crtc-invalid-params: SUCCESS (0.361s)
[429.738146] [073/133] (591s left) gem_eio (in-flight-suspend)
[429.937437] Starting subtest: in-flight-suspend
[472.933936] Subtest in-flight-suspend: SUCCESS (14.086s)
[473.127966] [074/133] (547s left) kms_busy (extended-pageflip-hang-oldfb)
[473.238471] Starting subtest: extended-pageflip-hang-oldfb
[473.243508] Starting dynamic subtest: pipe-A
[473.651749] Dynamic subtest pipe-A: SUCCESS (0.409s)
[473.665821] Starting dynamic subtest: pipe-D
[474.784920] Dynamic subtest pipe-D: SUCCESS (1.097s)
[474.787347] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.512s)
[475.659054] [075/133] (545s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[475.772215] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[482.620281] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.728s)
[482.781038] [076/133] (538s left) kms_content_protection (suspend-resume)
[482.929129] Starting subtest: suspend-resume
[482.933613] Subtest suspend-resume: SKIP (0.000s)
[483.043504] [077/133] (537s left) kms_selftest (drm_damage_helper)
[483.088375] Starting subtest: drm_damage_helper
[483.095336] Starting dynamic subtest: drm_test_damage_iter_no_damage
[483.190585] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.092s)
[483.205881] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[483.271300] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.079s)
[483.282247] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[483.393998] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.119s)
[483.404483] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[483.495374] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.100s)
[483.506935] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[483.596419] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.099s)
[483.607851] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[483.707314] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.109s)
[483.719137] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[483.813250] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.105s)
[483.822885] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[483.927317] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.110s)
[483.939670] Starting dynamic subtest: drm_test_damage_iter_single_damage
[484.021076] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.092s)
[484.031186] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[484.122105] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.099s)
[484.131985] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[484.215091] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.091s)
[484.224742] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[484.297960] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.082s)
[484.307150] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[484.386934] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.088s)
[484.398249] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[484.485533] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.095s)
[484.494791] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[484.590804] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.104s)
[484.599800] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[484.683983] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.092s)
[484.693116] Starting dynamic subtest: drm_test_damage_iter_damage
[484.785651] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.099s)
[484.794791] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[484.888112] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.101s)
[484.897107] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[484.975516] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.086s)
[484.986234] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[485.066156] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.089s)
[485.075278] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[485.171107] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.104s)
[485.173173] Subtest drm_damage_helper: SUCCESS (2.067s)
[485.334248] [078/133] (535s left) syncobj_timeline (etime-single-wait-submitted)
[485.398178] Starting subtest: etime-single-wait-submitted
[485.504134] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[485.587618] [079/133] (535s left) kms_pm_rpm (legacy-planes)
[487.828456] Starting subtest: legacy-planes
[487.831271] Starting dynamic subtest: plane-64
[496.156416] Dynamic subtest plane-64: SUCCESS (8.295s)
[496.169822] Starting dynamic subtest: plane-94
[504.456165] Dynamic subtest plane-94: SUCCESS (8.284s)
[504.469121] Starting dynamic subtest: plane-124
[512.785588] Dynamic subtest plane-124: SUCCESS (8.327s)
[512.797147] Starting dynamic subtest: plane-134
[521.183611] Dynamic subtest plane-134: SUCCESS (8.393s)
[521.186392] Subtest legacy-planes: SUCCESS (33.311s)
[521.560283] [080/133] (499s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[521.659853] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[525.949307] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.292s)
[527.148723] [081/133] (493s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[527.200795] Starting subtest: invalid-single-wait-all-unsubmitted
[527.202841] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[527.318672] [082/133] (493s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[527.408199] Starting subtest: crc-primary-basic-y-tiled-ccs
[527.410494] Starting dynamic subtest: pipe-A-eDP-1
[527.433325] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[527.444907] Starting dynamic subtest: pipe-B-eDP-1
[527.466908] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[527.477118] Starting dynamic subtest: pipe-C-eDP-1
[527.499266] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[527.510072] Starting dynamic subtest: pipe-D-eDP-1
[527.531886] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[527.536012] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[529.709996] [083/133] (491s left) gem_ppgtt (shrink-vs-evict-pinned)
[529.755436] Starting subtest: shrink-vs-evict-pinned
[535.600368] Subtest shrink-vs-evict-pinned: SUCCESS (5.841s)
[535.697219] [084/133] (485s left) syncobj_wait (single-wait-all-submitted)
[535.767707] Starting subtest: single-wait-all-submitted
[535.873490] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[535.972191] [085/133] (485s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[536.076509] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[536.080635] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[536.173576] [086/133] (485s left) kms_flip_tiling (flip-change-tiling)
[536.261586] Starting subtest: flip-change-tiling
[536.263762] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[536.423304] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.162s)
[536.435890] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[536.557625] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[536.570630] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[536.690957] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.130s)
[536.703345] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[536.834451] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[536.847292] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[536.978692] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[536.991307] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[537.123288] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[537.135740] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[537.256634] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[537.269532] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[537.367819] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[537.380883] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[537.502429] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[537.515275] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[537.646021] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[537.659075] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[537.790259] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[537.804042] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[537.934765] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[537.947858] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[538.068385] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[538.079897] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[538.203116] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[538.216282] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[538.312789] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s)
[538.325703] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[538.446390] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.131s)
[538.459899] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[538.590783] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[538.603881] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[538.746241] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.153s)
[538.761826] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[538.890782] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.141s)
[538.904132] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[539.035816] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[539.049502] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[539.180325] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[539.195718] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[539.301752] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[539.317321] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[539.445918] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[539.459667] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[539.590521] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[539.605947] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[539.735031] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[539.747873] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[539.879739] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[539.893136] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[540.012637] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.131s)
[540.027915] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[540.157112] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[540.171841] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[540.290853] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.131s)
[540.302532] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[540.436035] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[540.454221] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[540.592012] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.153s)
[540.606601] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[540.735656] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.141s)
[540.751465] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[540.880382] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[540.893365] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[541.024351] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[541.037893] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[541.169683] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[541.183147] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[541.291283] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[541.347373] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[542.566266] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.228s)
[542.579722] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[542.700349] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[542.713025] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[542.834604] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[542.852695] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[542.966083] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.131s)
[542.980131] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[543.109992] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[543.121698] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[543.254852] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[543.268282] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[543.389106] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[543.402010] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[543.499778] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[543.511646] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[543.634763] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[543.646829] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[543.777377] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[543.789075] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[543.921607] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[543.934513] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[544.066262] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[544.079303] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[544.199945] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[544.213230] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[544.334765] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[544.348110] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[544.444681] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[544.457870] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[544.588984] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[544.602381] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[544.733031] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[544.745927] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[544.877600] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[544.890423] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[545.022614] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[545.035094] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[545.167076] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[545.180412] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[545.311854] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[545.325198] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[545.433363] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[545.448729] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[545.577273] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[545.594807] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[545.722184] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[545.735335] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[545.866890] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[545.880033] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[546.011403] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[546.024612] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[546.156553] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[546.169238] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[546.300038] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.141s)
[546.312806] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[546.422784] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[546.434415] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[546.567509] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[546.580965] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[546.711583] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[546.725349] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[546.856439] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[546.868345] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[546.989499] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.131s)
[547.002793] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[547.133840] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[547.149752] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[547.278956] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[547.292425] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[547.400891] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[547.453999] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[548.701476] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.254s)
[548.714926] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[548.801495] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[548.814648] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[548.901224] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[548.913713] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[549.000961] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.099s)
[549.013659] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[549.100778] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.099s)
[549.112043] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[549.211756] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[549.223854] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[549.311776] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[549.330171] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[549.412703] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[549.423943] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[549.512599] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[549.523804] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[549.611990] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.098s)
[549.624925] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[549.722808] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[549.734726] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[549.833977] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[549.845987] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[549.934105] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[549.946522] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[550.034658] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[550.046976] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[550.134522] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[550.146908] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[550.245632] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[550.257809] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[550.356099] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[550.368398] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[550.456520] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.098s)
[550.467132] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[550.556545] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[550.569094] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[550.656938] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[550.668549] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[550.768302] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[550.779486] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[550.890428] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.120s)
[550.901957] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[551.001095] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[551.013618] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[551.111964] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[551.123158] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[551.223232] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[551.235910] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[551.334393] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.108s)
[551.349201] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[551.446059] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[551.457784] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[551.557226] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[551.571132] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[551.679283] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.119s)
[551.693896] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[551.790729] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[551.803705] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[551.901258] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[551.915666] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[552.012666] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[552.024149] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[552.124353] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[552.140887] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[552.235039] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.108s)
[552.247856] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[552.346299] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.108s)
[552.358396] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[552.457588] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[552.500089] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[553.748338] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.255s)
[553.761387] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[553.848320] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[553.860608] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[553.948068] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[553.960751] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[554.058919] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[554.071554] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[554.169610] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[554.184904] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[554.281522] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[554.293394] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[554.381305] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[554.399610] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[554.481816] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[554.499093] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[554.582077] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[554.595103] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[554.692500] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[554.705313] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[554.803128] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[554.815392] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[554.925507] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.121s)
[554.937649] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[555.025563] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[555.038117] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[555.127017] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[555.139747] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[555.226078] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[555.239523] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[555.337097] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[555.349481] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[555.447925] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[555.463285] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[555.559481] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[555.571420] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[555.659354] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s)
[555.671807] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[555.759639] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[555.771956] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[555.859918] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[555.872509] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[555.982556] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.120s)
[555.998030] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[556.103843] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.119s)
[556.116366] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[556.215008] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s)
[556.227688] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[556.315097] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.098s)
[556.327680] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[556.414801] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[556.427764] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[556.526405] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[556.542101] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[556.676012] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.148s)
[556.689067] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[556.786959] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[556.801405] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[556.898420] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[556.910477] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[556.998294] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s)
[557.009686] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[557.109796] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[557.121626] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[557.220679] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[557.232883] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[557.331767] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s)
[557.344512] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[557.442867] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[557.453752] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[557.554610] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[557.587378] Subtest flip-change-tiling: SUCCESS (21.320s)
[558.732168] [087/133] (462s left) gem_exec_reloc (basic-write-gtt)
[558.793667] Subtest basic-write-gtt: SKIP (0.000s)
[558.860861] [088/133] (462s left) syncobj_timeline (single-wait-signaled)
[558.939472] Starting subtest: single-wait-signaled
[558.941409] Subtest single-wait-signaled: SUCCESS (0.000s)
[559.051623] [089/133] (462s left) dumb_buffer (map-valid)
[559.116823] Starting subtest: map-valid
[559.118745] Subtest map-valid: SUCCESS (0.000s)
[559.205230] [090/133] (462s left) kms_flip (modeset-vs-vblank-race)
[559.304026] Starting subtest: modeset-vs-vblank-race
[559.306342] Starting dynamic subtest: A-eDP1
[564.068860] Dynamic subtest A-eDP1: SUCCESS (4.761s)
[564.085011] Starting dynamic subtest: B-eDP1
[568.807803] Dynamic subtest B-eDP1: SUCCESS (4.735s)
[568.821880] Starting dynamic subtest: C-eDP1
[573.345931] Dynamic subtest C-eDP1: SUCCESS (4.537s)
[573.356088] Starting dynamic subtest: D-eDP1
[577.889914] Dynamic subtest D-eDP1: SUCCESS (4.543s)
[577.892409] Subtest modeset-vs-vblank-race: SUCCESS (18.589s)
[579.060100] [091/133] (442s left) gem_mmap_wc (fault-concurrent)
[579.125133] Subtest fault-concurrent: SKIP (0.000s)
[579.186667] [092/133] (442s left) gem_ctx_isolation (dirty-switch)
[579.246344] Starting subtest: dirty-switch
[579.248559] Starting dynamic subtest: rcs0
[579.437722] Dynamic subtest rcs0: SUCCESS (0.194s)
[579.448346] Starting dynamic subtest: bcs0
[579.748745] Dynamic subtest bcs0: SUCCESS (0.309s)
[579.761456] Starting dynamic subtest: vcs0
[579.941217] Dynamic subtest vcs0: SUCCESS (0.192s)
[579.951190] Starting dynamic subtest: vcs1
[581.799099] Dynamic subtest vcs1: SUCCESS (1.857s)
[581.813360] Starting dynamic subtest: vecs0
[583.759278] Dynamic subtest vecs0: SUCCESS (1.960s)
[583.771796] Starting dynamic subtest: ccs0
[585.839551] Dynamic subtest ccs0: SUCCESS (2.079s)
[585.841900] Subtest dirty-switch: SUCCESS (6.597s)
[586.083769] [093/133] (435s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[586.130225] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[586.231844] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[586.313212] [094/133] (435s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[586.418330] Starting subtest: fbc-rgb101010-draw-render
[591.061766] Subtest fbc-rgb101010-draw-render: SUCCESS (4.646s)
[592.252969] [095/133] (429s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[592.354777] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[592.357024] Starting dynamic subtest: pipe-A-eDP-1
[603.690615] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.340s)
[603.702478] Starting dynamic subtest: pipe-B-eDP-1
[615.658439] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.965s)
[615.660710] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.308s)
[616.502308] [096/133] (405s left) gem_exec_params (no-vebox)
[616.566086] Starting subtest: no-vebox
[616.568365] Subtest no-vebox: SUCCESS (0.004s)
[618.640976] [097/133] (403s left) kms_flip (2x-busy-flip)
[618.730392] Starting subtest: 2x-busy-flip
[618.741592] Subtest 2x-busy-flip: SKIP (0.011s)
[618.818647] [098/133] (403s left) syncobj_timeline (invalid-query-illegal-handle)
[618.873006] Starting subtest: invalid-query-illegal-handle
[618.875023] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[618.985362] [099/133] (402s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[619.071217] Starting subtest: addfb25-yf-tiled-legacy
[619.073069] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[619.167927] [100/133] (402s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[619.262326] Starting subtest: x-tiled-16bpp-rotate-270
[619.282354] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[619.385666] [101/133] (402s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[619.481362] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[619.485217] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[619.581340] [102/133] (402s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[619.681695] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[619.683561] Starting dynamic subtest: pipe-A-eDP-1
[619.702554] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[619.714172] Starting dynamic subtest: pipe-B-eDP-1
[619.732687] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[619.741557] Starting dynamic subtest: pipe-C-eDP-1
[619.759585] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[619.768439] Starting dynamic subtest: pipe-D-eDP-1
[619.786472] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[619.790008] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[621.983443] [103/133] (400s left) kms_rotation_crc (cursor-rotation-180)
[622.080425] Starting subtest: cursor-rotation-180
[623.620852] Subtest cursor-rotation-180: SUCCESS (1.540s)
[624.828313] [104/133] (397s left) kms_cursor_crc (cursor-onscreen-512x512)
[625.103772] Starting subtest: cursor-onscreen-512x512
[625.108930] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[625.255367] [105/133] (396s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[625.633264] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[626.440129] [106/133] (395s left) kms_psr (psr-cursor-plane-onoff)
[626.549279] Starting subtest: psr-cursor-plane-onoff
[626.551540] Starting dynamic subtest: eDP-1
[628.249464] Dynamic subtest eDP-1: SUCCESS (1.700s)
[628.251947] Subtest psr-cursor-plane-onoff: SUCCESS (1.701s)
[629.121655] [107/133] (393s left) kms_cursor_crc (cursor-random-128x128)
[629.329619] Starting subtest: cursor-random-128x128
[629.334529] Starting dynamic subtest: pipe-A-eDP-1
[632.686633] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.352s)
[632.714904] Starting dynamic subtest: pipe-D-eDP-1
[636.704526] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.997s)
[636.706882] Subtest cursor-random-128x128: SUCCESS (7.373s)
[637.592266] [108/133] (384s left) gem_exec_gttfill (engines)
[637.659609] Starting subtest: engines
[637.662032] Starting dynamic subtest: rcs0
[660.564430] Dynamic subtest rcs0: SUCCESS (22.898s)
[660.579633] Starting dynamic subtest: bcs0
[683.919775] Dynamic subtest bcs0: SUCCESS (23.345s)
[683.931560] Starting dynamic subtest: vcs0
[707.272301] Dynamic subtest vcs0: SUCCESS (23.349s)
[707.293167] Starting dynamic subtest: vcs1
[730.577319] Dynamic subtest vcs1: SUCCESS (23.307s)
[730.588117] Starting dynamic subtest: vecs0
[753.930978] Dynamic subtest vecs0: SUCCESS (23.353s)
[753.943416] Starting dynamic subtest: ccs0
[777.250414] Dynamic subtest ccs0: SUCCESS (23.317s)
[777.253114] Subtest engines: SUCCESS (139.581s)
[777.440449] [109/133] (244s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[777.597927] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[777.602271] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[777.702388] [110/133] (244s left) prime_busy (after-wait)
[777.765685] Starting subtest: after-wait
[777.770613] Starting dynamic subtest: rcs0
[777.795066] Dynamic subtest rcs0: SUCCESS (0.026s)
[777.807137] Starting dynamic subtest: bcs0
[777.852899] Dynamic subtest bcs0: SUCCESS (0.056s)
[777.867437] Starting dynamic subtest: vcs0
[777.892217] Dynamic subtest vcs0: SUCCESS (0.039s)
[777.902274] Starting dynamic subtest: vcs1
[777.933504] Dynamic subtest vcs1: SUCCESS (0.040s)
[777.943368] Starting dynamic subtest: vecs0
[777.974839] Dynamic subtest vecs0: SUCCESS (0.038s)
[777.985944] Starting dynamic subtest: ccs0
[778.013561] Dynamic subtest ccs0: SUCCESS (0.040s)
[778.123064] Subtest after-wait: SUCCESS (0.355s)
[778.213646] [111/133] (244s left) kms_cursor_edge_walk (256x256-top-bottom)
[778.301479] Starting subtest: 256x256-top-bottom
[778.303823] Starting dynamic subtest: pipe-A-eDP-1
[781.770670] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.464s)
[781.784684] Starting dynamic subtest: pipe-D-eDP-1
[784.869206] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.103s)
[784.871564] Subtest 256x256-top-bottom: SUCCESS (6.569s)
[785.679998] [112/133] (236s left) kms_plane_lowres (tiling-yf)
[785.767930] Starting subtest: tiling-yf
[785.771869] Subtest tiling-yf: SKIP (0.000s)
[785.841088] [113/133] (236s left) gem_lmem_swapping (verify-random-ccs)
[785.903734] Subtest verify-random-ccs: SKIP (0.000s)
[785.948366] [114/133] (236s left) kms_psr (fbc-psr-sprite-plane-move)
[786.039189] Starting subtest: fbc-psr-sprite-plane-move
[786.041401] Starting dynamic subtest: eDP-1
[786.045425] Dynamic subtest eDP-1: SKIP (0.000s)
[786.049471] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[786.118578] [115/133] (236s left) prime_vgem (basic-fence-read)
[786.200661] Starting subtest: basic-fence-read
[786.219398] Subtest basic-fence-read: SKIP (0.017s)
[786.331763] [116/133] (236s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[786.427142] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[786.431231] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[786.501938] [117/133] (236s left) api_intel_bb (add-remove-objects)
[786.555714] Starting subtest: add-remove-objects
[786.562284] Subtest add-remove-objects: SUCCESS (0.009s)
[786.683499] [118/133] (236s left) gem_exec_schedule (u-submit-golden-slice)
[786.752826] Starting subtest: u-submit-golden-slice
[786.754525] Starting dynamic subtest: rcs0
[786.784415] Dynamic subtest rcs0: SUCCESS (0.038s)
[786.797343] Starting dynamic subtest: bcs0
[786.830104] Dynamic subtest bcs0: SUCCESS (0.045s)
[786.841850] Starting dynamic subtest: vcs0
[786.864464] Dynamic subtest vcs0: SUCCESS (0.033s)
[786.875613] Starting dynamic subtest: vcs1
[786.900326] Dynamic subtest vcs1: SUCCESS (0.036s)
[786.912509] Starting dynamic subtest: vecs0
[786.933831] Dynamic subtest vecs0: SUCCESS (0.033s)
[786.944104] Starting dynamic subtest: ccs0
[786.973596] Dynamic subtest ccs0: SUCCESS (0.039s)
[786.975536] Subtest u-submit-golden-slice: SUCCESS (0.227s)
[788.733825] [119/133] (234s left) gem_create (create-size-update)
[788.796858] Starting subtest: create-size-update
[788.798949] Subtest create-size-update: SUCCESS (0.000s)
[789.011474] [120/133] (233s left) kms_cdclk (mode-transition-all-outputs)
[789.104923] Starting subtest: mode-transition-all-outputs
[789.393085] Subtest mode-transition-all-outputs: SKIP (0.286s)
[790.221930] [121/133] (232s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[790.323867] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[790.328316] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[790.428511] [122/133] (232s left) gem_pipe_control_store_loop (reused-buffer)
[790.482394] Starting subtest: reused-buffer
[792.636144] Subtest reused-buffer: SUCCESS (2.152s)
[792.739781] [123/133] (230s left) vgem_basic (create)
[792.776129] Starting subtest: create
[792.778228] Subtest create: SUCCESS (0.000s)
[792.838258] [124/133] (230s left) gem_fence_thrash (bo-write-verify-none)
[792.868391] Starting subtest: bo-write-verify-none
[792.883445] Subtest bo-write-verify-none: SKIP (0.014s)
[792.945529] [125/133] (230s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[793.055623] Starting subtest: basic-busy-flip-before-cursor-legacy
[793.060111] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[793.225484] [126/133] (229s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[793.313110] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[799.927560] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.616s)
[800.061565] [127/133] (223s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[800.187511] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[800.192118] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[800.333895] [128/133] (222s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[800.430249] Starting subtest: plane-scaler-unity-scaling-with-rotation
[800.432165] Starting dynamic subtest: pipe-A
[800.656345] Dynamic subtest pipe-A: SUCCESS (0.228s)
[800.667324] Starting dynamic subtest: pipe-B
[801.918119] Dynamic subtest pipe-B: SUCCESS (1.260s)
[801.929113] Starting dynamic subtest: pipe-C
[803.251900] Dynamic subtest pipe-C: SUCCESS (1.332s)
[803.267950] Starting dynamic subtest: pipe-D
[804.590177] Dynamic subtest pipe-D: SUCCESS (1.336s)
[804.592492] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.162s)
[805.781658] [129/133] (217s left) kms_pm_dc (dc6-psr)
[806.884336] Starting subtest: dc6-psr
[809.867925] Subtest dc6-psr: SUCCESS (2.981s)
[810.705173] [130/133] (212s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[810.803691] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[810.808023] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[810.930421] [131/133] (212s left) gen9_exec_parse (basic-rejected-ctx-param)
[810.984104] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[811.053842] [132/133] (212s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[811.155793] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[811.160278] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[811.259409] [133/133] (212s left) kms_fbcon_fbt (fbc-suspend)
[811.318853] Starting subtest: fbc-suspend
[860.624074] Subtest fbc-suspend: SUCCESS (19.290s)
[861.950844] 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.