[57.327903] Initializing watchdogs
[57.327947]   /dev/watchdog0
[57.342777] [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.347252] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.349606] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.352831] [001/156] (960s left) kms_addfb_basic (clobberred-modifier)
[57.448045] Starting subtest: clobberred-modifier
[57.452373] Subtest clobberred-modifier: SKIP (0.000s)
[57.583511] [002/156] (960s left) gem_mmap (bad-size)
[57.638254] Subtest bad-size: SKIP (0.000s)
[57.688996] [003/156] (960s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[57.788268] Starting subtest: yf-tiled-8bpp-rotate-270
[57.792646] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[57.876456] [004/156] (960s left) gem_ccs (block-multicopy-compressed)
[57.934733] Starting subtest: block-multicopy-compressed
[57.939430] Subtest block-multicopy-compressed: SKIP (0.000s)
[58.028937] [005/156] (959s left) gem_eio (in-flight-external)
[58.163809] Starting subtest: in-flight-external
[59.361994] Subtest in-flight-external: SUCCESS (1.190s)
[59.477618] [006/156] (958s left) kms_psr (pr-sprite-plane-onoff)
[59.564926] Starting subtest: pr-sprite-plane-onoff
[59.569429] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[59.635787] [007/156] (958s left) gem_exec_whisper (basic-contexts)
[59.699738] Starting subtest: basic-contexts
[66.983420] Subtest basic-contexts: SUCCESS (7.258s)
[67.165741] [008/156] (950s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[67.271546] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[67.275698] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[67.358488] [009/156] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[67.466071] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[67.470688] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[67.553859] [010/156] (950s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[67.646313] Starting subtest: pixel-format-y-tiled-ccs-modifier
[67.650311] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[67.712764] [011/156] (950s left) core_auth (basic-auth)
[67.773613] Starting subtest: basic-auth
[67.775635] Subtest basic-auth: SUCCESS (0.001s)
[67.881246] [012/156] (950s left) gem_lmem_swapping (basic)
[67.924980] Subtest basic: SKIP (0.000s)
[67.970198] [013/156] (950s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-onoff)
[68.056727] Starting subtest: fbchdr-2p-primscrn-cur-indfb-onoff
[68.060993] Subtest fbchdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[68.172670] [014/156] (950s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-render)
[68.269959] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-render
[68.273725] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[68.367794] [015/156] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[68.461424] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[68.464996] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[68.541713] [016/156] (949s left) gem_exec_schedule (noreorder)
[68.723608] Starting subtest: noreorder
[68.725642] Starting dynamic subtest: rcs0
[68.795056] Dynamic subtest rcs0: SUCCESS (0.075s)
[68.804700] Starting dynamic subtest: vcs0
[70.261595] Dynamic subtest vcs0: SUCCESS (1.462s)
[70.275036] Starting dynamic subtest: vcs1
[72.343703] Dynamic subtest vcs1: SUCCESS (2.079s)
[72.358940] Starting dynamic subtest: vecs0
[74.298880] Dynamic subtest vecs0: SUCCESS (1.952s)
[74.310343] Starting dynamic subtest: ccs0
[74.370254] Dynamic subtest ccs0: SUCCESS (0.072s)
[74.373174] Subtest noreorder: SUCCESS (5.645s)
[74.553860] [017/156] (943s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[74.660165] Starting subtest: fbc-psr2-cursor-mmap-gtt
[74.662435] Starting dynamic subtest: eDP-1
[74.666531] Dynamic subtest eDP-1: SKIP (0.000s)
[74.670688] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[74.750414] [018/156] (943s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[74.849806] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[74.854388] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[74.944981] [019/156] (943s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[75.046075] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[75.050466] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[75.132999] [020/156] (943s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[75.182798] Starting subtest: etime-single-wait-all-for-submit-submitted
[75.288877] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[75.370752] [021/156] (943s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[75.476777] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[82.277046] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.806s)
[82.386229] [022/156] (936s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-blt)
[82.486861] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-blt
[82.491068] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[82.596354] [023/156] (936s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt)
[82.694474] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt
[82.698893] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[82.781339] [024/156] (935s left) gem_softpin (evict-prime-sanity-check)
[82.843106] Starting subtest: evict-prime-sanity-check
[82.845597] Starting dynamic subtest: rcs0
[84.003823] Dynamic subtest rcs0: SUCCESS (1.160s)
[84.016993] Starting dynamic subtest: bcs0
[85.123077] Dynamic subtest bcs0: SUCCESS (1.117s)
[85.136057] Starting dynamic subtest: vcs0
[86.255065] Dynamic subtest vcs0: SUCCESS (1.131s)
[86.266843] Starting dynamic subtest: vcs1
[88.316575] Dynamic subtest vcs1: SUCCESS (2.059s)
[88.326694] Starting dynamic subtest: vecs0
[90.275466] Dynamic subtest vecs0: SUCCESS (1.957s)
[90.288686] Starting dynamic subtest: ccs0
[91.412029] Dynamic subtest ccs0: SUCCESS (1.137s)
[91.424203] Starting dynamic subtest: all
[92.542059] Dynamic subtest all: SUCCESS (1.129s)
[92.544767] Subtest evict-prime-sanity-check: SUCCESS (9.697s)
[92.623071] [025/156] (926s left) perf_pmu (busy-idle-no-semaphores)
[92.664334] Starting subtest: busy-idle-no-semaphores
[92.666248] Starting dynamic subtest: rcs0
[93.314307] Dynamic subtest rcs0: SUCCESS (0.648s)
[93.324570] Starting dynamic subtest: bcs0
[93.970185] Dynamic subtest bcs0: SUCCESS (0.655s)
[93.984690] Starting dynamic subtest: vcs0
[94.623830] Dynamic subtest vcs0: SUCCESS (0.653s)
[94.635719] Starting dynamic subtest: vcs1
[95.908042] Dynamic subtest vcs1: SUCCESS (1.283s)
[95.919992] Starting dynamic subtest: vecs0
[97.891714] Dynamic subtest vecs0: SUCCESS (1.982s)
[97.902712] Starting dynamic subtest: ccs0
[99.878111] Dynamic subtest ccs0: SUCCESS (1.985s)
[99.881064] Subtest busy-idle-no-semaphores: SUCCESS (7.213s)
[100.020288] [026/156] (918s left) kms_color (degamma)
[100.123608] Starting subtest: degamma
[100.125778] Starting dynamic subtest: pipe-A-eDP-1
[100.867756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s)
[100.876796] Starting dynamic subtest: pipe-B-eDP-1
[102.271500] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.403s)
[102.280690] Starting dynamic subtest: pipe-C-eDP-1
[103.630838] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.359s)
[103.640894] Starting dynamic subtest: pipe-D-eDP-1
[104.976712] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s)
[104.979322] Subtest degamma: SUCCESS (4.852s)
[105.870290] [027/156] (912s left) api_intel_allocator (simple-allocator)
[105.926774] Starting subtest: simple-allocator
[105.928983] Starting dynamic subtest: basic
[105.931355] Dynamic subtest basic: SUCCESS (0.004s)
[105.943080] Starting dynamic subtest: parallel-one
[106.100132] Dynamic subtest parallel-one: SUCCESS (0.169s)
[106.111644] Starting dynamic subtest: print
[106.113515] Dynamic subtest print: SUCCESS (0.000s)
[106.122718] Starting dynamic subtest: reuse
[106.124916] Dynamic subtest reuse: SUCCESS (0.000s)
[106.133269] Starting dynamic subtest: reserve
[106.135437] Dynamic subtest reserve: SUCCESS (0.000s)
[106.143691] Starting dynamic subtest: fork-reopen-allocator
[106.145819] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[106.147993] Subtest simple-allocator: SUCCESS (0.188s)
[106.242963] [028/156] (912s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[106.335702] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[106.340164] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[106.452676] [029/156] (912s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[106.544494] Starting subtest: coverage-vs-premult-vs-constant
[106.817882] Starting dynamic subtest: pipe-A-eDP-1
[107.406333] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[107.417366] Starting dynamic subtest: pipe-D-eDP-1
[108.698269] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.290s)
[108.700719] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.151s)
[109.541329] [030/156] (909s left) gem_mmap_gtt (basic-write-read)
[109.598341] Subtest basic-write-read: SKIP (0.000s)
[109.653519] [031/156] (909s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[109.749425] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[109.751857] Starting dynamic subtest: pipe-A-default-mode
[112.484817] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s)
[112.487237] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.737s)
[113.357060] [032/156] (905s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[113.453406] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[113.455800] Starting dynamic subtest: pipe-A-eDP-1
[113.538342] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[113.547492] Starting dynamic subtest: pipe-B-eDP-1
[114.720749] Dynamic subtest pipe-B-eDP-1: SKIP (1.180s)
[114.725517] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.269s)
[115.905593] [033/156] (903s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[116.010271] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[116.014106] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[116.111729] [034/156] (903s left) kms_dirtyfb (default-dirtyfb-ioctl)
[116.205994] Starting subtest: default-dirtyfb-ioctl
[116.208339] Starting dynamic subtest: A-eDP-1
[117.811538] Dynamic subtest A-eDP-1: SUCCESS (1.606s)
[117.813916] Subtest default-dirtyfb-ioctl: SUCCESS (1.608s)
[118.641631] [035/156] (900s left) kms_content_protection (lic-type-0)
[118.772893] Starting subtest: lic-type-0
[118.777468] Subtest lic-type-0: SKIP (0.000s)
[118.894553] [036/156] (900s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[118.989722] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[118.993792] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[119.111020] [037/156] (900s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[119.162422] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[119.164842] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[119.272964] [038/156] (899s left) kms_dsc (dsc-with-bpc-formats)
[119.362155] Starting subtest: dsc-with-bpc-formats
[119.476207] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[119.514247] [039/156] (899s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[119.609156] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[119.612652] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[119.717651] [040/156] (899s left) gem_exec_balancer (parallel-contexts)
[119.995812] Starting subtest: parallel-contexts
[123.219538] Subtest parallel-contexts: SUCCESS (3.224s)
[123.572111] [041/156] (895s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[123.668546] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[123.672973] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[123.756830] [042/156] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[123.848561] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[123.853413] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[123.967923] [043/156] (895s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[124.065910] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[124.068298] Starting dynamic subtest: pipe-A-eDP-1
[124.076960] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[124.088257] Starting dynamic subtest: pipe-B-eDP-1
[124.097073] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[124.106063] Starting dynamic subtest: pipe-C-eDP-1
[124.114722] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[124.125940] Starting dynamic subtest: pipe-D-eDP-1
[124.134507] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[124.138877] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[126.320744] [044/156] (893s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[126.425853] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[126.428554] Starting dynamic subtest: A-eDP1
[130.056679] Dynamic subtest A-eDP1: SUCCESS (3.628s)
[130.066904] Starting dynamic subtest: B-eDP1
[133.269545] Dynamic subtest B-eDP1: SUCCESS (3.212s)
[133.279246] Starting dynamic subtest: C-eDP1
[136.490630] Dynamic subtest C-eDP1: SUCCESS (3.220s)
[136.500151] Starting dynamic subtest: D-eDP1
[139.718649] Dynamic subtest D-eDP1: SUCCESS (3.225s)
[139.721084] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.292s)
[140.528179] [045/156] (879s left) kms_invalid_mode (zero-vdisplay)
[140.626757] Starting subtest: zero-vdisplay
[140.629107] Starting dynamic subtest: pipe-A-eDP-1
[140.910322] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[140.919840] Starting dynamic subtest: pipe-B-eDP-1
[140.922337] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[140.931445] Starting dynamic subtest: pipe-C-eDP-1
[140.934690] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[140.943758] Starting dynamic subtest: pipe-D-eDP-1
[140.946152] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[140.948358] Subtest zero-vdisplay: SUCCESS (0.290s)
[141.758137] [046/156] (877s left) kms_chamelium_frames (hdmi-frame-dump)
[142.135238] Subtest hdmi-frame-dump: SKIP (0.000s)
[142.969344] [047/156] (876s left) syncobj_wait (invalid-wait-illegal-handle)
[143.024506] Starting subtest: invalid-wait-illegal-handle
[143.026846] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[143.111607] [048/156] (876s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[143.483821] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[144.300316] [049/156] (875s left) prime_vgem (fence-wait)
[144.476434] Starting subtest: fence-wait
[144.478408] Starting dynamic subtest: rcs0
[145.540826] Dynamic subtest rcs0: SUCCESS (1.064s)
[145.551226] Starting dynamic subtest: bcs0
[146.592861] Dynamic subtest bcs0: SUCCESS (1.050s)
[146.605023] Starting dynamic subtest: vcs0
[147.638463] Dynamic subtest vcs0: SUCCESS (1.044s)
[147.650698] Starting dynamic subtest: vcs1
[148.678433] Dynamic subtest vcs1: SUCCESS (1.038s)
[148.690914] Starting dynamic subtest: vecs0
[149.722445] Dynamic subtest vecs0: SUCCESS (1.042s)
[149.734602] Starting dynamic subtest: ccs0
[150.764639] Dynamic subtest ccs0: SUCCESS (1.040s)
[150.767476] Subtest fence-wait: SUCCESS (6.289s)
[150.899716] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[150.902494] [050/156] (868s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt)
[151.007152] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt
[151.011092] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[151.099245] [051/156] (868s left) kms_cursor_crc (cursor-random-512x512)
[151.382360] Starting subtest: cursor-random-512x512
[151.386970] Subtest cursor-random-512x512: SKIP (0.001s)
[151.570852] [052/156] (868s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[151.681588] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[151.685796] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[151.774119] [053/156] (868s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[151.867117] Starting subtest: y-tiled-64bpp-rotate-0
[151.870622] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[151.985673] [054/156] (867s left) kms_psr (fbc-pr-primary-page-flip)
[152.070338] Starting subtest: fbc-pr-primary-page-flip
[152.073667] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[152.153309] [055/156] (867s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[152.249931] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[156.732465] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.487s)
[157.921545] [056/156] (862s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[158.013205] Starting subtest: psr2-overlay-plane-move-continuous-sf
[158.015569] Starting dynamic subtest: pipe-A-eDP-1
[163.987095] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.979s)
[163.996889] Starting dynamic subtest: pipe-B-eDP-1
[170.692663] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.705s)
[170.695113] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.686s)
[171.573771] [057/156] (848s left) gem_userptr_blits (sd-probe)
[171.632716] Starting subtest: sd-probe
[171.635131] Subtest sd-probe: SUCCESS (0.000s)
[171.757308] [058/156] (848s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[171.847600] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[171.851937] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[171.976196] [059/156] (848s left) kms_cursor_crc (cursor-onscreen-512x512)
[172.272862] Starting subtest: cursor-onscreen-512x512
[172.277346] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[172.439843] [060/156] (847s left) kms_sequence (get-busy)
[172.540748] Starting subtest: get-busy
[172.542768] Starting dynamic subtest: pipe-A-eDP-1
[174.468406] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.924s)
[174.479882] Starting dynamic subtest: pipe-B-eDP-1
[177.076687] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.607s)
[177.087666] Starting dynamic subtest: pipe-C-eDP-1
[179.690045] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[179.699887] Starting dynamic subtest: pipe-D-eDP-1
[182.320071] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.627s)
[182.322291] Subtest get-busy: SUCCESS (9.775s)
[183.213658] [061/156] (837s left) gem_ctx_persistence (legacy-engines-queued)
[183.272224] Starting subtest: legacy-engines-queued
[183.274657] Starting dynamic subtest: render
[183.354949] Dynamic subtest render: SUCCESS (0.082s)
[183.366894] Starting dynamic subtest: bsd1
[185.241844] Dynamic subtest bsd1: SUCCESS (1.883s)
[185.254889] Starting dynamic subtest: bsd2
[187.227602] Dynamic subtest bsd2: SUCCESS (1.983s)
[187.239841] Starting dynamic subtest: blt
[187.270500] Dynamic subtest blt: SUCCESS (0.041s)
[187.280265] Starting dynamic subtest: vebox
[189.274494] Dynamic subtest vebox: SUCCESS (2.000s)
[189.277862] Subtest legacy-engines-queued: SUCCESS (6.002s)
[189.368543] [062/156] (830s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[189.471502] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[189.475581] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[189.578879] [063/156] (830s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[189.675959] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[189.680625] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[189.765418] [064/156] (830s left) gem_softpin (evict-active-interruptible)
[189.821529] Starting subtest: evict-active-interruptible
[189.829097] Subtest evict-active-interruptible: SUCCESS (0.008s)
[189.941353] [065/156] (830s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[190.059461] Starting subtest: basic-busy-flip-before-cursor-varying-size
[190.064122] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[190.203817] [066/156] (830s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[190.309292] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[190.312746] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[190.422226] [067/156] (830s left) kms_psr (fbc-psr-sprite-render)
[190.517471] Starting subtest: fbc-psr-sprite-render
[190.519465] Starting dynamic subtest: eDP-1
[190.523094] Dynamic subtest eDP-1: SKIP (0.000s)
[190.526839] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[190.590325] [068/156] (829s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[190.683251] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[190.686801] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[190.755119] [069/156] (829s left) kms_flip (nonblocking-read)
[190.839160] Starting subtest: nonblocking-read
[190.840696] Subtest nonblocking-read: SUCCESS (0.000s)
[190.913955] [070/156] (829s left) kms_tv_load_detect (load-detect)
[190.962111] Subtest load-detect: SKIP (0.000s)
[191.035007] [071/156] (829s left) gem_exec_parallel (basic)
[191.099281] Starting subtest: basic
[191.101220] Starting dynamic subtest: rcs0
[192.522398] Dynamic subtest rcs0: SUCCESS (1.422s)
[192.535031] Starting dynamic subtest: bcs0
[193.977129] Dynamic subtest bcs0: SUCCESS (1.454s)
[193.987086] Starting dynamic subtest: vcs0
[197.243784] Dynamic subtest vcs0: SUCCESS (3.263s)
[197.256257] Starting dynamic subtest: vcs1
[199.291590] Dynamic subtest vcs1: SUCCESS (2.046s)
[199.302449] Starting dynamic subtest: vecs0
[201.286295] Dynamic subtest vecs0: SUCCESS (1.993s)
[201.298468] Starting dynamic subtest: ccs0
[202.802834] Dynamic subtest ccs0: SUCCESS (1.515s)
[202.805226] Subtest basic: SUCCESS (11.703s)
[202.993779] [072/156] (817s left) syncobj_timeline (invalid-signal-illegal-handle)
[203.057470] Starting subtest: invalid-signal-illegal-handle
[203.059852] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[203.173064] [073/156] (817s left) kms_lease (lease-invalid-connector)
[203.276104] Starting subtest: lease-invalid-connector
[203.278499] Starting dynamic subtest: pipe-A-eDP-1
[203.280449] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[203.291035] Starting dynamic subtest: pipe-B-eDP-1
[203.293269] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[203.303739] Starting dynamic subtest: pipe-C-eDP-1
[203.305649] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[203.314288] Starting dynamic subtest: pipe-D-eDP-1
[203.316161] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[203.318091] Subtest lease-invalid-connector: SUCCESS (0.003s)
[203.361138] [074/156] (817s left) kms_big_fb (4-tiled-addfb-size-overflow)
[203.455788] Starting subtest: 4-tiled-addfb-size-overflow
[203.458142] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[203.544907] [075/156] (817s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[203.642787] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[203.647256] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[203.749836] [076/156] (817s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt)
[203.854968] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt
[203.859362] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[203.961096] [077/156] (816s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[204.041183] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[204.044868] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[204.116828] [078/156] (816s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-msflip-blt)
[204.212652] Starting subtest: psrhdr-1p-primscrn-indfb-msflip-blt
[204.216121] Subtest psrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[204.298110] [079/156] (816s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[204.351208] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[204.354880] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[204.541924] [080/156] (816s left) gem_exec_schedule (u-submit-golden-slice)
[204.603563] Starting subtest: u-submit-golden-slice
[204.605667] Starting dynamic subtest: rcs0
[204.635505] Dynamic subtest rcs0: SUCCESS (0.038s)
[204.647329] Starting dynamic subtest: bcs0
[204.670565] Dynamic subtest bcs0: SUCCESS (0.035s)
[204.680246] Starting dynamic subtest: vcs0
[204.705266] Dynamic subtest vcs0: SUCCESS (0.034s)
[204.716823] Starting dynamic subtest: vcs1
[204.742272] Dynamic subtest vcs1: SUCCESS (0.035s)
[204.752157] Starting dynamic subtest: vecs0
[204.777131] Dynamic subtest vecs0: SUCCESS (0.035s)
[204.786138] Starting dynamic subtest: ccs0
[204.816677] Dynamic subtest ccs0: SUCCESS (0.039s)
[204.819054] Subtest u-submit-golden-slice: SUCCESS (0.220s)
[206.349179] [081/156] (814s left) gem_create (create-invalid-size)
[206.414645] Starting subtest: create-invalid-size
[206.416609] Subtest create-invalid-size: SUCCESS (0.000s)
[206.610027] [082/156] (814s left) kms_hdr (static-toggle-suspend)
[206.702512] Starting subtest: static-toggle-suspend
[206.704829] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[206.709088] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[206.720045] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[206.724489] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[206.729026] Subtest static-toggle-suspend: SKIP (0.002s)
[206.773981] [083/156] (814s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[206.871076] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[206.874955] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[206.941356] [084/156] (814s left) api_intel_bb (simple-bb)
[206.990989] Starting subtest: simple-bb
[206.994067] Subtest simple-bb: SUCCESS (0.006s)
[207.132075] [085/156] (814s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[207.222620] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[210.954930] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.737s)
[212.129100] [086/156] (809s left) gem_workarounds (basic-read-fd)
[212.193192] Starting subtest: basic-read-fd
[212.206267] Subtest basic-read-fd: SUCCESS (0.014s)
[212.330282] [087/156] (808s left) gem_partial_pwrite_pread (writes-after-reads-display)
[212.389361] Subtest writes-after-reads-display: SKIP (0.000s)
[212.472291] [088/156] (808s left) core_sysfs (read-all-entries)
[212.532059] Starting subtest: read-all-entries
[212.536532] Subtest read-all-entries: SUCCESS (0.004s)
[212.639104] [089/156] (808s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[212.744595] Starting subtest: x-tiled-32bpp-rotate-180
[214.222436] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.479s)
[214.347904] [090/156] (807s left) perf_pmu (rc6)
[214.383817] Starting subtest: rc6
[214.386054] Starting dynamic subtest: gt0
[220.813351] Dynamic subtest gt0: SUCCESS (6.377s)
[220.826794] Starting dynamic subtest: runtime-pm-gt0
[228.478809] Dynamic subtest runtime-pm-gt0: SUCCESS (7.714s)
[228.493438] Starting dynamic subtest: runtime-pm-long-gt0
[240.958605] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.477s)
[240.971294] Starting dynamic subtest: other-idle-gt0
[247.357442] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[247.371067] Starting dynamic subtest: gt1
[253.701062] Dynamic subtest gt1: SUCCESS (6.339s)
[253.713493] Starting dynamic subtest: runtime-pm-gt1
[261.133267] Dynamic subtest runtime-pm-gt1: SUCCESS (7.486s)
[261.146076] Starting dynamic subtest: runtime-pm-long-gt1
[273.627467] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.491s)
[273.640077] Starting dynamic subtest: other-idle-gt1
[280.022314] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[280.024929] Subtest rc6: SUCCESS (65.585s)
[281.132064] [091/156] (740s left) vgem_basic (unload)
[281.166349] Starting subtest: unload
[310.294421] Subtest unload: SUCCESS (29.076s)
[310.333415] [092/156] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[310.431067] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[316.929288] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.504s)
[317.019271] [093/156] (704s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[317.123305] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[318.213981] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.090s)
[318.316529] [094/156] (703s left) i915_module_load (reload)
[318.352264] Starting subtest: reload
[323.057093] Subtest reload: SUCCESS (4.707s)
[323.097460] [095/156] (698s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[324.300059] Starting subtest: async-flip-with-page-flip-events-linear
[324.681182] Starting dynamic subtest: pipe-A-eDP-1
[327.479034] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.797s)
[327.838555] Starting dynamic subtest: pipe-B-eDP-1
[330.608811] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.776s)
[330.998086] Starting dynamic subtest: pipe-C-eDP-1
[333.749214] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.758s)
[334.120813] Starting dynamic subtest: pipe-D-eDP-1
[336.883518] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.773s)
[336.885948] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.585s)
[338.056297] [096/156] (683s left) gem_ctx_persistence (engines-queued)
[338.123613] Starting subtest: engines-queued
[338.126031] Starting dynamic subtest: rcs0
[338.224232] Dynamic subtest rcs0: SUCCESS (0.101s)
[338.235464] Starting dynamic subtest: bcs0
[338.247256] Dynamic subtest bcs0: SUCCESS (0.021s)
[338.255256] Starting dynamic subtest: vcs0
[340.304834] Dynamic subtest vcs0: SUCCESS (2.002s)
[340.316193] Starting dynamic subtest: vcs1
[342.233940] Dynamic subtest vcs1: SUCCESS (1.978s)
[342.247831] Starting dynamic subtest: vecs0
[344.332817] Dynamic subtest vecs0: SUCCESS (2.044s)
[344.344119] Starting dynamic subtest: ccs0
[344.489965] Dynamic subtest ccs0: SUCCESS (0.207s)
[344.492685] Subtest engines-queued: SUCCESS (6.366s)
[344.547141] [097/156] (677s left) gem_ctx_engines (execute-oneforall)
[344.614648] Starting subtest: execute-oneforall
[345.564336] Subtest execute-oneforall: SUCCESS (0.948s)
[346.379353] [098/156] (675s left) kms_prop_blob (basic)
[346.426111] Starting subtest: basic
[346.428068] Subtest basic: SUCCESS (0.000s)
[346.496790] [099/156] (675s left) perf_pmu (invalid-init)
[346.535236] Starting subtest: invalid-init
[346.537497] Subtest invalid-init: SUCCESS (0.000s)
[346.627511] [100/156] (675s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[346.733182] Starting subtest: fbcpsr-shrfb-scaledprimary
[352.550744] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.821s)
[352.669057] [101/156] (669s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt)
[352.771050] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt
[352.775468] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[352.827740] [102/156] (669s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[352.912050] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[352.916379] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[354.022199] [103/156] (667s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[354.120287] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[354.122654] Starting dynamic subtest: pipe-A-eDP-1
[354.148122] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[354.159374] Starting dynamic subtest: pipe-B-eDP-1
[354.181203] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[354.189925] Starting dynamic subtest: pipe-C-eDP-1
[354.211475] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[354.219628] Starting dynamic subtest: pipe-D-eDP-1
[354.241343] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[354.245728] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[356.390717] [104/156] (665s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[356.476331] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[356.485303] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[356.536785] [105/156] (665s left) perf (short-reads)
[356.626718] Starting subtest: short-reads
[356.640424] Subtest short-reads: SUCCESS (0.016s)
[356.688819] [106/156] (665s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[356.790121] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[356.794489] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[356.854972] [107/156] (665s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[356.951297] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[356.953609] Starting dynamic subtest: pipe-A
[356.974351] Dynamic subtest pipe-A: SKIP (0.020s)
[356.985093] Starting dynamic subtest: pipe-B
[357.007448] Dynamic subtest pipe-B: SKIP (0.033s)
[357.016066] Starting dynamic subtest: pipe-C
[357.044892] Dynamic subtest pipe-C: SKIP (0.036s)
[357.053358] Starting dynamic subtest: pipe-D
[357.076413] Dynamic subtest pipe-D: SKIP (0.031s)
[357.080761] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.122s)
[357.177120] [108/156] (664s left) vgem_basic (bad-flag)
[357.217526] Starting subtest: bad-flag
[357.219758] Subtest bad-flag: SUCCESS (0.000s)
[357.257790] [109/156] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[357.357841] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[357.361128] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[357.446527] [110/156] (664s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[357.572584] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[357.713953] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.143s)
[357.804282] [111/156] (664s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[357.901837] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[357.905204] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[357.989863] [112/156] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[358.089488] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[358.093126] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[358.164841] [113/156] (664s left) gem_exec_params (invalid-bsd2-flag-on-render)
[358.224557] Starting subtest: invalid-bsd2-flag-on-render
[358.226843] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[358.293653] [114/156] (664s left) syncobj_timeline (etime-multi-wait-all-submitted)
[358.342487] Starting subtest: etime-multi-wait-all-submitted
[358.447839] Subtest etime-multi-wait-all-submitted: SUCCESS (0.103s)
[358.503307] [115/156] (663s left) kms_rotation_crc (sprite-rotation-90)
[358.589089] Starting subtest: sprite-rotation-90
[358.593536] Subtest sprite-rotation-90: SKIP (0.001s)
[358.635979] [116/156] (663s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[358.740023] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[358.744183] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[358.811740] [117/156] (663s left) gem_pxp (reject-modify-context-protection-on)
[358.873164] Starting subtest: reject-modify-context-protection-on
[358.875451] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[358.952954] [118/156] (663s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[359.062175] Starting subtest: cursorB-vs-flipB-atomic
[359.066624] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[359.182759] [119/156] (663s left) syncobj_timeline (wait-for-submit-delayed-submit)
[359.244456] Starting subtest: wait-for-submit-delayed-submit
[359.345904] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[359.400664] [120/156] (663s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[359.494376] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[359.495991] Starting dynamic subtest: pipe-A-eDP-1
[359.515290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[359.524182] Starting dynamic subtest: pipe-B-eDP-1
[359.541062] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[359.554048] Starting dynamic subtest: pipe-C-eDP-1
[359.572477] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[359.581255] Starting dynamic subtest: pipe-D-eDP-1
[359.598825] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[359.600890] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.084s)
[361.842416] [121/156] (660s left) i915_pm_rps (thresholds-park)
[361.903765] Starting subtest: thresholds-park
[361.908406] Subtest thresholds-park: SKIP (0.001s)
[361.987360] [122/156] (660s left) perf (unprivileged-single-ctx-counters)
[362.048235] Starting subtest: unprivileged-single-ctx-counters
[362.052825] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[362.097359] [123/156] (660s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[362.359597] Starting subtest: parallel-dmabuf-import-out-fence
[363.471885] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.116s)
[363.546355] [124/156] (659s left) kms_atomic_transition (plane-all-modeset-transition)
[363.644490] Starting subtest: plane-all-modeset-transition
[363.648659] Subtest plane-all-modeset-transition: SKIP (0.000s)
[363.692952] [125/156] (659s left) gem_exec_gttfill (multigpu-basic)
[363.871217] Starting subtest: multigpu-basic
[377.487826] Subtest multigpu-basic: SUCCESS (13.620s)
[377.546578] [126/156] (645s left) kms_properties (crtc-properties-legacy)
[377.700021] Starting subtest: crtc-properties-legacy
[377.701915] Starting dynamic subtest: pipe-A-eDP-1
[378.180742] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.482s)
[378.190850] Starting dynamic subtest: pipe-B-eDP-1
[379.317914] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.135s)
[379.327859] Starting dynamic subtest: pipe-C-eDP-1
[380.444917] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[380.454756] Starting dynamic subtest: pipe-D-eDP-1
[381.571815] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[381.574005] Subtest crtc-properties-legacy: SUCCESS (3.874s)
[382.374675] [127/156] (640s left) kms_async_flips (test-time-stamp)
[382.466048] Starting subtest: test-time-stamp
[382.852735] Starting dynamic subtest: pipe-A-eDP-1
[383.706472] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.852s)
[384.084330] Starting dynamic subtest: pipe-B-eDP-1
[384.936246] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.858s)
[385.319276] Starting dynamic subtest: pipe-C-eDP-1
[386.084957] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.773s)
[386.457556] Starting dynamic subtest: pipe-D-eDP-1
[387.220900] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[387.223386] Subtest test-time-stamp: SUCCESS (4.755s)
[388.368094] [128/156] (634s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[388.468124] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-pwrite
[388.471994] Subtest psrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[388.543338] [129/156] (634s left) kms_chamelium_audio (hdmi-audio)
[388.919049] Subtest hdmi-audio: SKIP (0.000s)
[389.707511] [130/156] (633s left) i915_pm_rpm (debugfs-read)
[391.439288] Starting subtest: debugfs-read
[392.595288] Subtest debugfs-read: SUCCESS (1.158s)
[392.958157] [131/156] (630s left) gen7_exec_parse (cmd-crossing-page)
[393.016964] Subtest cmd-crossing-page: SKIP (0.000s)
[393.095942] [132/156] (630s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[393.197919] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[399.872858] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.680s)
[399.976630] [133/156] (623s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[400.072292] Starting subtest: psr-rgb101010-draw-mmap-cpu
[407.158508] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.091s)
[407.248161] [134/156] (615s left) kms_big_fb (linear-16bpp-rotate-180)
[407.346786] Starting subtest: linear-16bpp-rotate-180
[408.749059] Subtest linear-16bpp-rotate-180: SUCCESS (1.402s)
[408.844594] [135/156] (614s left) kms_vblank (wait-busy)
[408.943341] Starting subtest: wait-busy
[408.945123] Starting dynamic subtest: pipe-A-eDP-1
[410.826672] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s)
[410.842870] Starting dynamic subtest: pipe-D-eDP-1
[413.406065] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.578s)
[413.408233] Subtest wait-busy: SUCCESS (4.462s)
[414.202226] [136/156] (609s left) kms_scaling_modes (scaling-mode-full-aspect)
[414.289280] Starting subtest: scaling-mode-full-aspect
[414.291542] Starting dynamic subtest: pipe-A-eDP-1
[414.386462] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.099s)
[414.397427] Starting dynamic subtest: pipe-B-eDP-1
[415.553565] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.165s)
[415.564079] Starting dynamic subtest: pipe-C-eDP-1
[416.684658] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s)
[416.694969] Starting dynamic subtest: pipe-D-eDP-1
[417.808898] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[417.811243] Subtest scaling-mode-full-aspect: SUCCESS (3.522s)
[418.947546] [137/156] (604s left) gem_render_copy (y-tiled)
[419.004057] Starting subtest: y-tiled
[419.008589] Subtest y-tiled: SKIP (0.000s)
[419.166147] [138/156] (604s left) gem_mmap_offset (bad-object)
[419.222094] Starting subtest: bad-object
[419.224482] Subtest bad-object: SUCCESS (0.001s)
[419.302601] [139/156] (604s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[419.426988] Starting subtest: cursorB-vs-flipA-legacy
[419.431547] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[419.547701] [140/156] (603s left) gem_userptr_blits (access-control)
[419.631501] Starting subtest: access-control
[419.635869] Subtest access-control: SKIP (0.000s)
[419.723083] [141/156] (603s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[419.819144] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[419.823447] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[419.901527] [142/156] (603s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[420.005061] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[420.007272] Starting dynamic subtest: pipe-A
[421.151497] Dynamic subtest pipe-A: SUCCESS (1.151s)
[421.161560] Starting dynamic subtest: pipe-B
[423.319649] Dynamic subtest pipe-B: SUCCESS (2.167s)
[423.330171] Starting dynamic subtest: pipe-C
[424.565673] Dynamic subtest pipe-C: SUCCESS (1.245s)
[424.575128] Starting dynamic subtest: pipe-D
[425.803252] Dynamic subtest pipe-D: SUCCESS (1.237s)
[425.805623] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.803s)
[426.966874] [143/156] (596s left) gem_softpin (invalid)
[427.026066] Starting subtest: invalid
[427.030533] Subtest invalid: SUCCESS (0.007s)
[427.119767] [144/156] (596s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[427.218691] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[427.222709] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[427.288780] [145/156] (596s left) kms_pm_rpm (cursor)
[429.554134] Starting subtest: cursor
[429.560628] Subtest cursor: SKIP (0.000s)
[429.884450] [146/156] (593s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[429.981285] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[437.696987] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.722s)
[437.786592] [147/156] (585s left) kms_psr (psr-primary-mmap-gtt)
[437.889301] Starting subtest: psr-primary-mmap-gtt
[437.891678] Starting dynamic subtest: eDP-1
[439.341996] Dynamic subtest eDP-1: SKIP (1.450s)
[439.347483] Subtest psr-primary-mmap-gtt: SKIP (1.452s)
[439.477018] [148/156] (584s left) perf_pmu (render-node-busy-idle)
[439.545078] Starting subtest: render-node-busy-idle
[439.547522] Starting dynamic subtest: rcs0
[440.238896] Dynamic subtest rcs0: SUCCESS (0.693s)
[440.251575] Starting dynamic subtest: bcs0
[440.898931] Dynamic subtest bcs0: SUCCESS (0.658s)
[440.910922] Starting dynamic subtest: vcs0
[442.300075] Dynamic subtest vcs0: SUCCESS (1.397s)
[442.312910] Starting dynamic subtest: vcs1
[444.284554] Dynamic subtest vcs1: SUCCESS (1.981s)
[444.297070] Starting dynamic subtest: vecs0
[446.270878] Dynamic subtest vecs0: SUCCESS (1.982s)
[446.281994] Starting dynamic subtest: ccs0
[446.938574] Dynamic subtest ccs0: SUCCESS (0.667s)
[446.941177] Subtest render-node-busy-idle: SUCCESS (7.394s)
[446.991465] [149/156] (576s left) syncobj_wait (wait-all-snapshot)
[447.061145] Starting subtest: wait-all-snapshot
[447.144044] Subtest wait-all-snapshot: SUCCESS (0.082s)
[447.201376] [150/156] (576s left) gem_exec_fence (submit3)
[447.392889] Starting subtest: submit3
[447.397828] Subtest submit3: SKIP (0.000s)
[449.335492] [151/156] (574s left) vgem_basic (setversion)
[449.379893] Starting subtest: setversion
[449.384134] Subtest setversion: SUCCESS (0.000s)
[449.422394] [152/156] (574s left) i915_drm_fdinfo (context-close-stress)
[449.472740] Starting subtest: context-close-stress
[460.271222] Subtest context-close-stress: SUCCESS (10.746s)
[460.314718] [153/156] (563s left) kms_flip (2x-wf_vblank-ts-check)
[460.547222] Starting subtest: 2x-wf_vblank-ts-check
[460.558492] Subtest 2x-wf_vblank-ts-check: SKIP (0.012s)
[460.613854] [154/156] (563s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[460.725960] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[460.730323] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[460.804872] [155/156] (563s left) gem_exec_balancer (bonded-chain)
[460.885794] Starting subtest: bonded-chain
[467.911452] Subtest bonded-chain: SUCCESS (7.024s)
[468.187816] [156/156] (555s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-blt)
[468.289213] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-blt
[468.293380] Subtest hdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[468.364840] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: gem_mmap
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_ccs
results: parsing output: 4/ for test: gem_eio
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: core_auth
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_softpin
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_color
results: parsing output: 26/ for test: api_intel_allocator
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane_alpha_blend
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_dirtyfb
results: parsing output: 34/ for test: kms_content_protection
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_dsc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_balancer
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_invalid_mode
results: parsing output: 45/ for test: kms_chamelium_frames
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: prime_vgem
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_sequence
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_softpin
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_tv_load_detect
results: parsing output: 70/ for test: gem_exec_parallel
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_lease
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_plane
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: gem_create
results: parsing output: 81/ for test: kms_hdr
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_workarounds
results: parsing output: 86/ for test: gem_partial_pwrite_pread
results: parsing output: 87/ for test: core_sysfs
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: vgem_basic
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: i915_module_load
results: parsing output: 94/ for test: kms_async_flips
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: gem_ctx_engines
results: parsing output: 97/ for test: kms_prop_blob
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: vgem_basic
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_pxp
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_params
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_rotation_crc
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_pxp
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: i915_pm_rps
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: kms_atomic_transition
results: parsing output: 124/ for test: gem_exec_gttfill
results: parsing output: 125/ for test: kms_properties
results: parsing output: 126/ for test: kms_async_flips
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_chamelium_audio
results: parsing output: 129/ for test: i915_pm_rpm
results: parsing output: 130/ for test: gen7_exec_parse
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_big_fb
results: parsing output: 134/ for test: kms_vblank
results: parsing output: 135/ for test: kms_scaling_modes
results: parsing output: 136/ for test: gem_render_copy
results: parsing output: 137/ for test: gem_mmap_offset
results: parsing output: 138/ for test: kms_cursor_legacy
results: parsing output: 139/ for test: gem_userptr_blits
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_plane_scaling
results: parsing output: 142/ for test: gem_softpin
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_pm_rpm
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_psr
results: parsing output: 147/ for test: perf_pmu
results: parsing output: 148/ for test: syncobj_wait
results: parsing output: 149/ for test: gem_exec_fence
results: parsing output: 150/ for test: vgem_basic
results: parsing output: 151/ for test: i915_drm_fdinfo
results: parsing output: 152/ for test: kms_flip
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_exec_balancer
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.