[146.523592] Initializing watchdogs
[146.523647]   /dev/watchdog0
[146.540295] [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]
[146.545159] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[146.547500] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[146.549918] [001/133] (960s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[146.811192] Starting subtest: cursor-rapid-movement-256x85
[146.863923] Subtest cursor-rapid-movement-256x85: SKIP (0.052s)
[147.043901] [002/133] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[147.129491] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[147.131272] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[147.198400] [003/133] (959s left) kms_plane_alpha_blend (alpha-transparent-fb)
[147.277140] Starting subtest: alpha-transparent-fb
[147.562494] Starting dynamic subtest: pipe-A-eDP-1
[148.218591] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.656s)
[148.226122] Starting dynamic subtest: pipe-D-eDP-1
[149.613970] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.394s)
[149.615298] Subtest alpha-transparent-fb: SUCCESS (2.337s)
[150.514462] [004/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[150.599324] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[150.601047] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[150.697503] [005/133] (956s left) gem_softpin (allocator-fork)
[150.765504] Starting subtest: allocator-fork
[152.986051] Subtest allocator-fork: SUCCESS (2.212s)
[153.098096] [006/133] (954s left) perf_pmu (semaphore-busy)
[153.131660] Starting subtest: semaphore-busy
[153.132587] Starting dynamic subtest: rcs0
[154.783575] Dynamic subtest rcs0: SUCCESS (1.641s)
[154.792268] Starting dynamic subtest: bcs0
[156.418041] Dynamic subtest bcs0: SUCCESS (1.634s)
[156.426830] Starting dynamic subtest: vcs0
[160.407538] Dynamic subtest vcs0: SUCCESS (3.987s)
[160.416523] Starting dynamic subtest: vcs1
[166.422700] Dynamic subtest vcs1: SUCCESS (6.014s)
[166.431714] Starting dynamic subtest: vecs0
[172.438609] Dynamic subtest vecs0: SUCCESS (6.014s)
[172.446710] Starting dynamic subtest: ccs0
[175.513562] Dynamic subtest ccs0: SUCCESS (3.074s)
[175.514453] Subtest semaphore-busy: SUCCESS (22.373s)
[175.612155] [007/133] (931s left) api_intel_bb (blit-noreloc-purge-cache)
[175.658928] Starting subtest: blit-noreloc-purge-cache
[175.667320] Subtest blit-noreloc-purge-cache: SUCCESS (0.009s)
[175.750866] [008/133] (931s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[175.849452] Starting subtest: psr-2p-primscrn-cur-indfb-move
[175.851164] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[175.934425] [009/133] (931s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[176.030774] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[176.033353] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[176.121992] [010/133] (931s left) gem_softpin (invalid)
[176.175496] Starting subtest: invalid
[176.183552] Subtest invalid: SUCCESS (0.008s)
[176.301624] [011/133] (931s left) sysfs_heartbeat_interval (invalid)
[176.350379] Starting subtest: invalid
[176.351460] Starting dynamic subtest: vecs0
[176.352587] Dynamic subtest vecs0: SUCCESS (0.000s)
[176.360573] Starting dynamic subtest: ccs0
[176.361441] Dynamic subtest ccs0: SUCCESS (0.000s)
[176.367721] Starting dynamic subtest: vcs0
[176.368592] Dynamic subtest vcs0: SUCCESS (0.000s)
[176.374711] Starting dynamic subtest: bcs0
[176.375617] Dynamic subtest bcs0: SUCCESS (0.000s)
[176.381733] Starting dynamic subtest: rcs0
[176.382755] Dynamic subtest rcs0: SUCCESS (0.000s)
[176.388886] Starting dynamic subtest: vcs1
[176.389754] Dynamic subtest vcs1: SUCCESS (0.000s)
[176.390624] Subtest invalid: SUCCESS (0.003s)
[176.461473] [012/133] (930s left) kms_vrr (flip-dpms)
[176.549126] Starting subtest: flip-dpms
[176.551973] Subtest flip-dpms: SKIP (0.000s)
[176.646263] [013/133] (930s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[176.736428] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[183.816088] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.081s)
[183.971690] [014/133] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[184.063464] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[184.065411] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[184.146544] [015/133] (923s left) kms_pm_dc (dc6-psr)
[185.236589] Starting subtest: dc6-psr
[188.117576] Subtest dc6-psr: SUCCESS (2.880s)
[188.947721] [016/133] (918s left) kms_plane_scaling (intel-max-src-size)
[189.038978] Starting subtest: intel-max-src-size
[189.041728] Subtest intel-max-src-size: SKIP (0.000s)
[189.137071] [017/133] (918s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[189.238882] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[189.240689] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[189.303380] [018/133] (918s left) prime_vgem (coherency-blt)
[189.437942] Starting subtest: coherency-blt
[190.549277] Subtest coherency-blt: SUCCESS (1.103s)
[190.685849] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[190.687868] [019/133] (916s left) i915_drm_fdinfo (virtual-busy-idle-all)
[190.720361] Starting subtest: virtual-busy-idle-all
[190.722476] Subtest virtual-busy-idle-all: SKIP (0.000s)
[190.797988] [020/133] (916s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[190.846580] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[190.848000] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[190.954679] [021/133] (916s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[191.044491] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[191.045493] Starting dynamic subtest: pipe-A-eDP-1
[191.120617] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[191.129627] Starting dynamic subtest: pipe-B-eDP-1
[192.227382] Dynamic subtest pipe-B-eDP-1: SKIP (1.105s)
[192.229104] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.185s)
[193.449174] [022/133] (914s left) prime_self_import (basic-llseek-size)
[193.481956] Starting subtest: basic-llseek-size
[193.495073] Subtest basic-llseek-size: SUCCESS (0.013s)
[193.592990] [023/133] (914s left) kms_lease (invalid-create-leases)
[193.684215] Starting subtest: invalid-create-leases
[193.688902] Subtest invalid-create-leases: SUCCESS (0.005s)
[193.787552] [024/133] (914s left) syncobj_timeline (invalid-signal-illegal-point)
[193.829998] Starting subtest: invalid-signal-illegal-point
[193.830908] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[193.918130] [025/133] (913s left) kms_psr (psr-sprite-mmap-gtt)
[193.996400] Starting subtest: psr-sprite-mmap-gtt
[193.997477] Starting dynamic subtest: eDP-1
[195.469242] Dynamic subtest eDP-1: SKIP (1.461s)
[195.471592] Subtest psr-sprite-mmap-gtt: SKIP (1.463s)
[195.639559] [026/133] (912s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[195.691780] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[195.816378] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[195.868636] [027/133] (912s left) gem_request_retire (retire-vma-not-inactive)
[195.918955] Starting subtest: retire-vma-not-inactive
[195.977675] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[196.091882] [028/133] (911s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[196.179544] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[196.180530] Starting dynamic subtest: pipe-A-eDP-1
[196.184551] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[196.193269] Starting dynamic subtest: pipe-B-eDP-1
[196.196981] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[196.204187] Starting dynamic subtest: pipe-C-eDP-1
[196.207958] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[196.214849] Starting dynamic subtest: pipe-D-eDP-1
[196.218483] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[196.220328] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[198.422857] [029/133] (909s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[198.518239] Starting subtest: plane-upscale-20x20-with-rotation
[198.519180] Starting dynamic subtest: pipe-A
[198.743641] Dynamic subtest pipe-A: SUCCESS (0.226s)
[198.752042] Starting dynamic subtest: pipe-B
[200.026057] Dynamic subtest pipe-B: SUCCESS (1.282s)
[200.034096] Starting dynamic subtest: pipe-C
[201.363180] Dynamic subtest pipe-C: SUCCESS (1.336s)
[201.370748] Starting dynamic subtest: pipe-D
[202.698700] Dynamic subtest pipe-D: SUCCESS (1.335s)
[202.699618] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.182s)
[203.895964] [030/133] (904s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[203.979121] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[203.980019] Starting dynamic subtest: pipe-A-eDP-1
[203.999806] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[204.007769] Starting dynamic subtest: pipe-B-eDP-1
[204.021708] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[204.028896] Starting dynamic subtest: pipe-C-eDP-1
[204.043437] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[204.050475] Starting dynamic subtest: pipe-D-eDP-1
[204.064615] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[204.065495] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s)
[206.337732] [031/133] (901s left) kms_vrr (max-min)
[206.432382] Starting subtest: max-min
[206.434897] Subtest max-min: SKIP (0.000s)
[206.509565] [032/133] (901s left) gem_pxp (create-regular-buffer)
[206.642908] Starting subtest: create-regular-buffer
[206.643949] Subtest create-regular-buffer: SUCCESS (0.000s)
[206.743256] [033/133] (901s left) kms_pm_rpm (modeset-non-lpsp-stress)
[208.293073] Starting subtest: modeset-non-lpsp-stress
[209.448970] Subtest modeset-non-lpsp-stress: SKIP (1.155s)
[209.845959] [034/133] (898s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[209.967092] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[209.969237] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[210.104315] [035/133] (898s left) gem_exec_schedule (u-fairslice-all)
[210.152333] Starting subtest: u-fairslice-all
[212.210868] Subtest u-fairslice-all: SUCCESS (2.058s)
[213.916511] [036/133] (894s left) perf (blocking)
[214.041907] Starting subtest: blocking
[214.042739] Starting dynamic subtest: 0-rcs0
[224.114208] Dynamic subtest 0-rcs0: SUCCESS (10.026s)
[224.123123] Starting dynamic subtest: 1-vecs0
[234.139660] Dynamic subtest 1-vecs0: SUCCESS (10.023s)
[234.140962] Subtest blocking: SUCCESS (20.051s)
[234.171928] [037/133] (874s left) kms_cursor_edge_walk (128x128-top-edge)
[234.257922] Starting subtest: 128x128-top-edge
[234.258799] Starting dynamic subtest: pipe-A-eDP-1
[237.710797] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.451s)
[237.718087] Starting dynamic subtest: pipe-D-eDP-1
[240.845919] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[240.847504] Subtest 128x128-top-edge: SUCCESS (6.580s)
[241.657518] [038/133] (866s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[241.703290] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[241.821033] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[241.901139] [039/133] (866s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[241.993469] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[241.994356] Starting dynamic subtest: pipe-A-eDP-1
[242.083129] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[242.095752] Starting dynamic subtest: pipe-B-eDP-1
[243.236868] Dynamic subtest pipe-B-eDP-1: SKIP (1.152s)
[243.238802] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.243s)
[244.430804] [040/133] (863s left) kms_addfb_basic (unused-pitches)
[244.476942] Starting subtest: unused-pitches
[244.478046] Subtest unused-pitches: SUCCESS (0.000s)
[244.593024] [041/133] (863s left) kms_busy (extended-pageflip-hang-newfb)
[244.692080] Starting subtest: extended-pageflip-hang-newfb
[244.693080] Starting dynamic subtest: pipe-A
[270.705455] Dynamic subtest pipe-A: SUCCESS (26.011s)
[270.713601] Starting dynamic subtest: pipe-D
[296.690152] Dynamic subtest pipe-D: SUCCESS (25.982s)
[296.691065] Subtest extended-pageflip-hang-newfb: SUCCESS (51.997s)
[297.488356] [042/133] (810s left) kms_hdr (static-toggle-dpms)
[297.579449] Starting subtest: static-toggle-dpms
[297.582221] Subtest static-toggle-dpms: SKIP (0.000s)
[297.648248] [043/133] (810s left) gem_mmap_gtt (cpuset-big-copy-odd)
[297.701389] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[297.751717] [044/133] (810s left) gem_exec_whisper (basic-contexts-priority-all)
[297.801741] Starting subtest: basic-contexts-priority-all
[319.260180] Subtest basic-contexts-priority-all: SUCCESS (21.447s)
[319.430947] [045/133] (789s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[319.498263] Starting subtest: basic-batch-kernel-default-cmd
[319.500182] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[319.681792] [046/133] (788s left) kms_color_pipeline (plane-lut1d-lut1d)
[319.772132] Starting subtest: plane-lut1d-lut1d
[319.953919] Starting dynamic subtest: pipe-A-plane-0
[320.220812] Dynamic subtest pipe-A-plane-0: FAIL (0.210s)
[320.228771] Starting dynamic subtest: pipe-A-plane-1
[320.419950] Dynamic subtest pipe-A-plane-1: FAIL (0.187s)
[320.427094] Starting dynamic subtest: pipe-A-plane-2
[320.640519] Dynamic subtest pipe-A-plane-2: FAIL (0.188s)
[321.695408] Starting dynamic subtest: pipe-B-plane-0
[321.951156] Dynamic subtest pipe-B-plane-0: FAIL (0.164s)
[321.959169] Starting dynamic subtest: pipe-B-plane-1
[322.140876] Dynamic subtest pipe-B-plane-1: FAIL (0.177s)
[322.149855] Starting dynamic subtest: pipe-B-plane-2
[322.325969] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[323.421503] Starting dynamic subtest: pipe-C-plane-0
[323.708103] Dynamic subtest pipe-C-plane-0: FAIL (0.162s)
[323.716478] Starting dynamic subtest: pipe-C-plane-1
[323.876994] Dynamic subtest pipe-C-plane-1: FAIL (0.146s)
[323.885075] Starting dynamic subtest: pipe-C-plane-2
[324.045789] Dynamic subtest pipe-C-plane-2: FAIL (0.165s)
[325.072471] Starting dynamic subtest: pipe-D-plane-0
[325.372640] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[325.380707] Starting dynamic subtest: pipe-D-plane-1
[325.561168] Dynamic subtest pipe-D-plane-1: FAIL (0.155s)
[325.570936] Starting dynamic subtest: pipe-D-plane-2
[325.753989] Dynamic subtest pipe-D-plane-2: FAIL (0.337s)
[326.004052] Subtest plane-lut1d-lut1d: FAIL (6.231s)
[326.830622] [047/133] (781s left) kms_psr (pr-dpms)
[326.937634] Starting subtest: pr-dpms
[326.939491] Subtest pr-dpms: SKIP (0.000s)
[327.007919] [048/133] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[327.100052] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[327.101749] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[327.190174] [049/133] (781s left) kms_rotation_crc (sprite-rotation-270)
[327.275116] Starting subtest: sprite-rotation-270
[327.277128] Subtest sprite-rotation-270: SKIP (0.001s)
[327.340190] [050/133] (781s left) kms_plane_multiple (tiling-y)
[327.433507] Starting subtest: tiling-y
[327.435219] Subtest tiling-y: SKIP (0.000s)
[327.505825] [051/133] (781s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[327.600094] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[328.425609] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[328.612050] [052/133] (780s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[328.704088] Starting subtest: 2x-flip-vs-modeset-vs-hang
[328.714826] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[328.788833] [053/133] (780s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[328.884089] Starting subtest: 4-tiled-64bpp-rotate-90
[328.904394] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[329.029375] [054/133] (779s left) gem_lmem_swapping (heavy-verify-random-ccs)
[329.067303] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[329.109580] [055/133] (779s left) kms_psr (fbc-psr-cursor-plane-move)
[329.205441] Starting subtest: fbc-psr-cursor-plane-move
[329.206372] Starting dynamic subtest: eDP-1
[329.208217] Dynamic subtest eDP-1: SKIP (0.000s)
[329.209853] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[329.288791] [056/133] (779s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[329.338493] Starting subtest: yf-tiled-ccs-to-yf-tiled
[329.340291] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[329.526800] [057/133] (779s left) kms_getfb (getfb2-handle-closed)
[329.618152] Starting subtest: getfb2-handle-closed
[329.619044] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[329.726878] [058/133] (779s left) gem_ctx_persistence (legacy-engines-queued)
[329.781881] Starting subtest: legacy-engines-queued
[329.782770] Starting dynamic subtest: render
[329.861305] Dynamic subtest render: SUCCESS (0.079s)
[329.872723] Starting dynamic subtest: bsd1
[331.900955] Dynamic subtest bsd1: SUCCESS (2.027s)
[331.911028] Starting dynamic subtest: bsd2
[333.883382] Dynamic subtest bsd2: SUCCESS (1.980s)
[333.893709] Starting dynamic subtest: blt
[333.926092] Dynamic subtest blt: SUCCESS (0.050s)
[333.935578] Starting dynamic subtest: vebox
[335.867066] Dynamic subtest vebox: SUCCESS (1.929s)
[335.868136] Subtest legacy-engines-queued: SUCCESS (6.076s)
[335.934561] [059/133] (773s left) kms_flip (2x-flip-vs-dpms-on-nop)
[336.041773] Starting subtest: 2x-flip-vs-dpms-on-nop
[336.052519] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[336.141377] [060/133] (772s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[336.231345] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[336.232971] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[336.317771] [061/133] (772s left) kms_big_fb (x-tiled-addfb)
[336.415298] Starting subtest: x-tiled-addfb
[336.416396] Subtest x-tiled-addfb: SUCCESS (0.000s)
[336.507598] [062/133] (772s left) gem_exec_reloc (basic-gtt-read-active)
[336.564929] Subtest basic-gtt-read-active: SKIP (0.000s)
[336.620152] [063/133] (772s left) kms_content_protection (atomic)
[336.756397] Starting subtest: atomic
[336.758604] Subtest atomic: SKIP (0.000s)
[336.874499] [064/133] (772s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[336.965179] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[336.966934] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[337.063573] [065/133] (772s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[337.185388] Starting subtest: basic-flip-before-cursor-legacy
[338.111210] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.925s)
[338.967514] [066/133] (770s left) gem_exec_fence (expired-history)
[339.437527] Starting subtest: expired-history
[346.695691] Subtest expired-history: SUCCESS (7.250s)
[347.212642] [067/133] (762s left) gem_exec_balancer (individual)
[347.273434] Starting subtest: individual
[348.867397] Subtest individual: SUCCESS (1.586s)
[349.177274] [068/133] (760s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[349.272140] Starting subtest: fbc-psr2-primary-mmap-gtt
[349.272947] Starting dynamic subtest: eDP-1
[349.274839] Dynamic subtest eDP-1: SKIP (0.000s)
[349.276392] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[349.352209] [069/133] (760s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[349.402576] Starting subtest: multi-wait-available-unsubmitted-signaled
[349.403345] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[349.509688] [070/133] (759s left) kms_flip (blocking-absolute-wf_vblank)
[349.612769] Starting subtest: blocking-absolute-wf_vblank
[349.614728] Starting dynamic subtest: A-eDP1
[358.368297] Dynamic subtest A-eDP1: SUCCESS (8.725s)
[358.380323] Starting dynamic subtest: B-eDP1
[367.104690] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[367.114790] Starting dynamic subtest: C-eDP1
[375.838496] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[375.848859] Starting dynamic subtest: D-eDP1
[384.569046] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[384.570024] Subtest blocking-absolute-wf_vblank: SUCCESS (34.919s)
[385.739393] [071/133] (723s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[385.785565] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[385.888742] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[385.974522] [072/133] (723s left) kms_psr (psr2-sprite-render)
[386.057139] Starting subtest: psr2-sprite-render
[386.057998] Starting dynamic subtest: eDP-1
[387.749401] Dynamic subtest eDP-1: SUCCESS (1.692s)
[387.750313] Subtest psr2-sprite-render: SUCCESS (1.693s)
[388.620751] [073/133] (720s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[388.707376] Starting subtest: fbc-rgb101010-draw-render
[393.321251] Subtest fbc-rgb101010-draw-render: SUCCESS (4.614s)
[394.499913] [074/133] (715s left) i915_pm_rps (waitboost)
[394.559546] Starting subtest: waitboost
[400.900088] Subtest waitboost: SUCCESS (6.330s)
[400.963905] [075/133] (708s left) gem_exec_schedule (preempt-other-chain)
[401.013324] Starting subtest: preempt-other-chain
[401.014625] Starting dynamic subtest: rcs0
[401.161789] Dynamic subtest rcs0: SUCCESS (0.139s)
[401.173590] Starting dynamic subtest: bcs0
[401.286033] Dynamic subtest bcs0: SUCCESS (0.132s)
[401.297619] Starting dynamic subtest: vcs0
[401.419858] Dynamic subtest vcs0: SUCCESS (0.124s)
[401.428150] Starting dynamic subtest: vcs1
[401.550382] Dynamic subtest vcs1: SUCCESS (0.130s)
[401.562922] Starting dynamic subtest: vecs0
[401.670031] Dynamic subtest vecs0: SUCCESS (0.128s)
[401.685855] Starting dynamic subtest: ccs0
[401.816581] Dynamic subtest ccs0: SUCCESS (0.137s)
[401.817833] Subtest preempt-other-chain: SUCCESS (0.794s)
[402.918650] [076/133] (706s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[403.035741] Starting subtest: flip-vs-cursor-crc-legacy
[403.717852] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.681s)
[404.518763] [077/133] (705s left) kms_draw_crc (draw-method-blt)
[404.602286] Starting subtest: draw-method-blt
[404.603206] Starting dynamic subtest: xrgb8888-untiled
[404.823852] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[404.831668] Starting dynamic subtest: rgb565-untiled
[405.046147] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[405.053433] Starting dynamic subtest: xrgb2101010-untiled
[405.268446] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[405.276380] Starting dynamic subtest: xbgr16161616f-untiled
[405.479556] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[405.487810] Starting dynamic subtest: xrgb8888-xtiled
[405.590685] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[405.598331] Starting dynamic subtest: rgb565-xtiled
[405.702049] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[405.713533] Starting dynamic subtest: xrgb2101010-xtiled
[405.813234] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[405.823377] Starting dynamic subtest: xbgr16161616f-xtiled
[405.923917] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.109s)
[405.931736] Starting dynamic subtest: xrgb8888-4tiled
[406.046076] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[406.053516] Starting dynamic subtest: rgb565-4tiled
[406.168637] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[406.178071] Starting dynamic subtest: xrgb2101010-4tiled
[406.268501] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[406.277368] Starting dynamic subtest: xbgr16161616f-4tiled
[406.390773] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.120s)
[406.391778] Subtest draw-method-blt: SUCCESS (1.789s)
[406.501072] [078/133] (703s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[406.599403] Starting subtest: y-tiled-32bpp-rotate-180
[406.601301] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[406.692212] [079/133] (703s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[406.788359] Starting subtest: bad-aux-stride-y-tiled-ccs
[406.789269] Starting dynamic subtest: pipe-A-eDP-1
[406.797619] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[406.805304] Starting dynamic subtest: pipe-B-eDP-1
[406.813654] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[406.821415] Starting dynamic subtest: pipe-C-eDP-1
[406.829555] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[406.836892] Starting dynamic subtest: pipe-D-eDP-1
[406.844960] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[406.846741] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[409.084433] [080/133] (700s left) template (b)
[409.136584] Starting subtest: B
[409.137493] Subtest B: SUCCESS (0.000s)
[409.231816] [081/133] (700s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[409.323675] Starting subtest: psr-1p-primscrn-cur-indfb-move
[416.678891] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.355s)
[416.819446] [082/133] (692s left) kms_dp_link_training (non-uhbr-mst)
[416.939636] Starting subtest: non-uhbr-mst
[416.943402] Subtest non-uhbr-mst: SKIP (0.000s)
[417.017829] [083/133] (692s left) perf (polling)
[417.106537] Starting subtest: polling
[417.107587] Starting dynamic subtest: 0-rcs0
[427.180374] Dynamic subtest 0-rcs0: SUCCESS (10.028s)
[427.190606] Starting dynamic subtest: 1-vcs0
[437.205179] Dynamic subtest 1-vcs0: SUCCESS (10.023s)
[437.205991] Subtest polling: SUCCESS (20.054s)
[437.235806] [084/133] (672s left) gem_ccs (block-copy-compressed)
[437.290874] Starting subtest: block-copy-compressed
[437.292753] Subtest block-copy-compressed: SKIP (0.000s)
[437.390222] [085/133] (672s left) gem_exec_params (invalid-bsd2-flag-on-render)
[437.443522] Starting subtest: invalid-bsd2-flag-on-render
[437.444523] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[437.560984] [086/133] (672s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[437.653017] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[437.743892] [087/133] (672s left) gem_exec_reloc (basic-cpu-read)
[437.795824] Subtest basic-cpu-read: SKIP (0.000s)
[437.859090] [088/133] (672s left) kms_chamelium_color (ctm-negative)
[437.945621] Subtest ctm-negative: SKIP (0.000s)
[437.986740] [089/133] (672s left) kms_rmfb (close-fd)
[438.078043] Starting subtest: close-fd
[438.078833] Starting dynamic subtest: pipe-A-eDP-1
[438.186711] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[438.201229] Starting dynamic subtest: pipe-B-eDP-1
[439.366455] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.180s)
[439.375924] Starting dynamic subtest: pipe-C-eDP-1
[440.503087] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.135s)
[440.511141] Starting dynamic subtest: pipe-D-eDP-1
[441.640155] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[441.641115] Subtest close-fd: SUCCESS (3.561s)
[442.859548] [090/133] (667s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[442.959477] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[442.961199] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[443.060199] [091/133] (667s left) gem_flink_race (flink_name)
[443.094454] Starting subtest: flink_name
[448.518214] Subtest flink_name: SUCCESS (5.399s)
[448.593841] [092/133] (661s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[448.699738] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[455.776606] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.076s)
[455.917884] [093/133] (654s left) gem_ringfill (basic-all)
[461.919273] Starting subtest: basic-all
[463.095960] Subtest basic-all: SUCCESS (1.173s)
[463.195484] [094/133] (647s left) i915_pm_rps (basic-api)
[463.250567] Starting subtest: basic-api
[463.252470] Subtest basic-api: SKIP (0.001s)
[463.354443] [095/133] (646s left) gem_wait (write-wait)
[463.412551] Starting subtest: write-wait
[463.413642] Starting dynamic subtest: all-engines
[464.516362] Dynamic subtest all-engines: SUCCESS (1.103s)
[464.535832] Starting dynamic subtest: rcs0
[465.575459] Dynamic subtest rcs0: SUCCESS (1.056s)
[465.595081] Starting dynamic subtest: bcs0
[466.634037] Dynamic subtest bcs0: SUCCESS (1.057s)
[466.651590] Starting dynamic subtest: vcs0
[467.690426] Dynamic subtest vcs0: SUCCESS (1.054s)
[467.707685] Starting dynamic subtest: vcs1
[468.744862] Dynamic subtest vcs1: SUCCESS (1.053s)
[468.760325] Starting dynamic subtest: vecs0
[469.800825] Dynamic subtest vecs0: SUCCESS (1.052s)
[469.817270] Starting dynamic subtest: ccs0
[470.857820] Dynamic subtest ccs0: SUCCESS (1.055s)
[470.861369] Subtest write-wait: SUCCESS (7.446s)
[471.052356] [096/133] (639s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[471.148059] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[474.874380] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.726s)
[476.075733] [097/133] (634s left) gem_ctx_shared (detached-shared-gtt)
[476.144390] Starting subtest: detached-shared-gtt
[478.341998] Subtest detached-shared-gtt: SUCCESS (2.152s)
[478.689871] [098/133] (631s left) gem_linear_blits (basic)
[479.063518] Starting subtest: basic
[479.078479] Subtest basic: SUCCESS (0.015s)
[479.203745] [099/133] (631s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[479.369286] Starting subtest: short-flip-before-cursor-atomic-transitions
[480.348597] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.979s)
[481.184815] [100/133] (629s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[481.571066] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[482.386276] [101/133] (628s left) gem_exec_gttfill (engines)
[482.438335] Starting subtest: engines
[482.439342] Starting dynamic subtest: rcs0
[505.180237] Dynamic subtest rcs0: SUCCESS (22.730s)
[505.190349] Starting dynamic subtest: bcs0
[528.471448] Dynamic subtest bcs0: SUCCESS (23.296s)
[528.483750] Starting dynamic subtest: vcs0
[551.758043] Dynamic subtest vcs0: SUCCESS (23.285s)
[551.767776] Starting dynamic subtest: vcs1
[575.102787] Dynamic subtest vcs1: SUCCESS (23.343s)
[575.111191] Starting dynamic subtest: vecs0
[598.424240] Dynamic subtest vecs0: SUCCESS (23.320s)
[598.435158] Starting dynamic subtest: ccs0
[621.759343] Dynamic subtest ccs0: SUCCESS (23.333s)
[621.762349] Subtest engines: SUCCESS (139.317s)
[621.945894] [102/133] (488s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[622.079376] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[622.081243] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[622.165733] [103/133] (488s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[622.262295] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[622.264080] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[622.350850] [104/133] (488s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[622.455838] Starting subtest: 2x-flip-vs-rmfb-interruptible
[622.467245] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[622.541053] [105/133] (488s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[622.633614] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[622.635332] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[622.719976] [106/133] (487s left) core_getversion (all-cards)
[622.759633] Starting subtest: all-cards
[622.774462] Subtest all-cards: SUCCESS (0.017s)
[622.816948] [107/133] (487s left) gem_ctx_exec (basic-nohangcheck)
[622.871779] Starting subtest: basic-nohangcheck
[623.132503] Subtest basic-nohangcheck: SUCCESS (0.262s)
[623.241165] [108/133] (487s left) kms_psr (fbc-pr-no-drrs)
[623.337530] Starting subtest: fbc-pr-no-drrs
[623.339237] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[623.417240] [109/133] (487s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[623.468769] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[623.527990] [110/133] (487s left) i915_drm_fdinfo (most-busy-check-all)
[623.572590] Starting subtest: most-busy-check-all
[623.573553] Starting dynamic subtest: rcs0
[623.576925] Dynamic subtest rcs0: SKIP (0.003s)
[623.585909] Starting dynamic subtest: bcs0
[623.587602] Dynamic subtest bcs0: SKIP (0.000s)
[623.594967] Starting dynamic subtest: vcs0
[623.596543] Dynamic subtest vcs0: SKIP (0.000s)
[623.604058] Starting dynamic subtest: vcs1
[623.605742] Dynamic subtest vcs1: SKIP (0.000s)
[623.613171] Starting dynamic subtest: vecs0
[623.614873] Dynamic subtest vecs0: SKIP (0.000s)
[623.622347] Starting dynamic subtest: ccs0
[623.623957] Dynamic subtest ccs0: SKIP (0.001s)
[623.625726] Subtest most-busy-check-all: SKIP (0.009s)
[623.656921] [111/133] (487s left) gen3_render_tiledy_blits
[623.794185] [112/133] (487s left) gem_softpin (evict-active)
[623.850114] Starting subtest: evict-active
[623.853814] Subtest evict-active: SUCCESS (0.005s)
[623.968142] [113/133] (486s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[624.066091] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[624.067941] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[624.150739] [114/133] (486s left) gem_exec_params (invalid-bsd1-flag-on-render)
[624.214104] Starting subtest: invalid-bsd1-flag-on-render
[624.214933] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[624.302398] [115/133] (486s left) kms_atomic (crtc-invalid-params)
[624.386352] Starting subtest: crtc-invalid-params
[624.387291] Starting dynamic subtest: pipe-A-eDP-1
[624.773778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.387s)
[624.774669] Subtest crtc-invalid-params: SUCCESS (0.389s)
[625.632039] [116/133] (485s left) gem_exec_fence (parallel)
[625.805548] Starting subtest: parallel
[625.806558] Starting dynamic subtest: rcs0
[627.951197] Dynamic subtest rcs0: SUCCESS (2.151s)
[627.960198] Starting dynamic subtest: bcs0
[630.104169] Dynamic subtest bcs0: SUCCESS (2.152s)
[630.113885] Starting dynamic subtest: vcs0
[632.257441] Dynamic subtest vcs0: SUCCESS (2.152s)
[632.265765] Starting dynamic subtest: vcs1
[634.406836] Dynamic subtest vcs1: SUCCESS (2.149s)
[634.415715] Starting dynamic subtest: vecs0
[636.560159] Dynamic subtest vecs0: SUCCESS (2.152s)
[636.572673] Starting dynamic subtest: ccs0
[638.718566] Dynamic subtest ccs0: SUCCESS (2.157s)
[638.719988] Subtest parallel: SUCCESS (12.919s)
[640.981492] [117/133] (470s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[641.083064] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[641.954801] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.658s)
[641.986894] [118/133] (469s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[642.083557] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[642.085428] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[642.176683] [119/133] (468s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[642.273588] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[642.275266] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[642.377505] [120/133] (468s left) kms_cursor_crc (cursor-onscreen-512x512)
[642.639286] Starting subtest: cursor-onscreen-512x512
[642.640984] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[642.792414] [121/133] (468s left) gem_ctx_engines (execute-allforone)
[642.841468] Starting subtest: execute-allforone
[642.855663] Subtest execute-allforone: SUCCESS (0.014s)
[644.976567] [122/133] (466s left) gen9_exec_parse (bb-start-far)
[645.035076] Subtest bb-start-far: SKIP (0.000s)
[645.095866] [123/133] (466s left) gem_exec_fence (basic-busy-all)
[645.160698] Starting subtest: basic-busy-all
[645.225292] Subtest basic-busy-all: SUCCESS (0.067s)
[647.004796] [124/133] (464s left) gem_caching (read-writes)
[647.059111] Subtest read-writes: SKIP (0.000s)
[647.124783] [125/133] (464s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[647.183094] Starting subtest: single-wait-all-for-submit-available-signaled
[647.184074] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[647.284453] [126/133] (464s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[647.369934] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[647.371635] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[647.466402] [127/133] (463s left) gem_mmap_offset (bad-flags)
[647.513320] Starting subtest: bad-flags
[647.514195] Subtest bad-flags: SUCCESS (0.000s)
[647.608660] [128/133] (463s left) kms_vblank (invalid)
[647.690112] Starting subtest: invalid
[647.690889] Starting dynamic subtest: pipe-A-eDP-1
[648.097923] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[648.098867] Subtest invalid: SUCCESS (0.409s)
[648.970106] [129/133] (462s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[649.060452] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[649.061315] Starting dynamic subtest: pipe-A-eDP-1
[649.068612] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[649.079980] Starting dynamic subtest: pipe-B-eDP-1
[649.088044] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[649.098201] Starting dynamic subtest: pipe-C-eDP-1
[649.104946] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[649.113077] Starting dynamic subtest: pipe-D-eDP-1
[649.119922] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[649.120707] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.010s)
[651.343174] [130/133] (460s left) syncobj_wait (invalid-signal-one-illegal-handle)
[651.402942] Starting subtest: invalid-signal-one-illegal-handle
[651.404050] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[651.514209] [131/133] (460s left) api_intel_bb (simple-bb-ctx)
[651.574950] Starting subtest: simple-bb-ctx
[651.582889] Subtest simple-bb-ctx: SUCCESS (0.009s)
[651.693313] [132/133] (459s left) kms_chamelium_color (gamma)
[651.791122] Subtest gamma: SKIP (0.000s)
[651.832225] [133/133] (459s left) gem_ctx_param (set-priority-not-supported)
[651.887839] Starting subtest: set-priority-not-supported
[651.889834] Subtest set-priority-not-supported: SKIP (0.000s)
[651.945447] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: kms_plane_alpha_blend
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: api_intel_bb
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_softpin
results: parsing output: 10/ for test: sysfs_heartbeat_interval
results: parsing output: 11/ for test: kms_vrr
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_pm_dc
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: prime_vgem
results: parsing output: 18/ for test: i915_drm_fdinfo
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: prime_self_import
results: parsing output: 22/ for test: kms_lease
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: gem_request_retire
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_vrr
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: perf
results: parsing output: 36/ for test: kms_cursor_edge_walk
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: kms_busy
results: parsing output: 41/ for test: kms_hdr
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: gem_exec_whisper
results: parsing output: 44/ for test: gem_exec_flush
results: parsing output: 45/ for test: kms_color_pipeline
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: kms_plane_multiple
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_lmem_swapping
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: kms_getfb
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: i915_pm_rps
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_draw_crc
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: template
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_dp_link_training
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: gem_ccs
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_chamelium_color
results: parsing output: 88/ for test: kms_rmfb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_flink_race
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_ringfill
results: parsing output: 93/ for test: i915_pm_rps
results: parsing output: 94/ for test: gem_wait
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_ctx_shared
results: parsing output: 97/ for test: gem_linear_blits
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_chamelium_hpd
results: parsing output: 100/ for test: gem_exec_gttfill
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: core_getversion
results: parsing output: 106/ for test: gem_ctx_exec
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_pipe_b_c_ivb
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: gen3_render_tiledy_blits
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_atomic
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gem_ctx_engines
results: parsing output: 121/ for test: gen9_exec_parse
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: gem_caching
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_mmap_offset
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: api_intel_bb
results: parsing output: 131/ for test: kms_chamelium_color
results: parsing output: 132/ for test: gem_ctx_param
Done.