[59.588854] Initializing watchdogs
[59.588903]   /dev/watchdog0
[59.604506] [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]
[59.608862] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.611149] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.613016] [001/133] (960s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[59.704337] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[59.706366] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[59.768026] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-y)
[59.824962] Subtest fault-concurrent-Y: SKIP (0.000s)
[59.883562] [003/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[59.969826] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[59.971932] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.055359] [004/133] (960s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[60.436918] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[61.192209] [005/133] (959s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[61.289518] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[61.290503] Starting dynamic subtest: pipe-A-eDP-1
[62.652813] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.379s)
[62.939673] Starting dynamic subtest: pipe-B-eDP-1
[63.980922] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s)
[64.248982] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.992s)
[65.072649] [006/133] (955s left) gem_mmap_wc (read)
[65.131522] Subtest read: SKIP (0.000s)
[65.184771] [007/133] (955s left) kms_dsc (dsc-basic)
[65.278598] Starting subtest: dsc-basic
[65.284362] Subtest dsc-basic: SKIP (0.000s)
[65.358939] [008/133] (954s left) kms_addfb_basic (unused-offsets)
[65.414715] Starting subtest: unused-offsets
[65.415757] Subtest unused-offsets: SUCCESS (0.000s)
[65.546025] [009/133] (954s left) gem_pxp (create-valid-protected-context)
[65.669324] Starting subtest: create-valid-protected-context
[65.672565] Subtest create-valid-protected-context: SUCCESS (0.003s)
[65.781790] [010/133] (954s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[65.867743] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[65.868769] Starting dynamic subtest: pipe-A-eDP-1
[66.796477] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.932s)
[66.804317] Starting dynamic subtest: pipe-B-eDP-1
[68.395776] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.608s)
[68.403102] Starting dynamic subtest: pipe-C-eDP-1
[69.901972] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.505s)
[69.908974] Starting dynamic subtest: pipe-D-eDP-1
[71.441902] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.553s)
[71.442847] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.601s)
[72.649235] [011/133] (947s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[72.899546] Starting subtest: fbcpsr-stridechange
[79.365247] Subtest fbcpsr-stridechange: SUCCESS (6.479s)
[79.493708] [012/133] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[79.588070] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[79.589829] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[79.688386] [013/133] (940s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[79.772251] Starting subtest: psr2-plane-move-sf-dmg-area
[79.773160] Starting dynamic subtest: pipe-A-eDP-1
[84.298920] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.530s)
[84.307398] Starting dynamic subtest: pipe-B-eDP-1
[89.620633] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.321s)
[89.621466] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.853s)
[90.482244] [014/133] (930s left) kms_cursor_edge_walk (64x64-top-edge)
[90.570584] Starting subtest: 64x64-top-edge
[90.571587] Starting dynamic subtest: pipe-A-eDP-1
[94.071654] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.501s)
[94.082987] Starting dynamic subtest: pipe-D-eDP-1
[97.193136] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[97.194334] Subtest 64x64-top-edge: SUCCESS (6.622s)
[97.999237] [015/133] (922s left) vgem_basic (dmabuf-mmap)
[98.071485] Starting subtest: dmabuf-mmap
[98.079933] Subtest dmabuf-mmap: SUCCESS (0.009s)
[98.148409] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[98.150792] [016/133] (922s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[98.229767] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[98.230881] Starting dynamic subtest: pipe-A
[98.293627] Dynamic subtest pipe-A: SUCCESS (0.065s)
[98.302985] Starting dynamic subtest: pipe-B
[99.418761] Dynamic subtest pipe-B: SUCCESS (1.123s)
[99.429293] Starting dynamic subtest: pipe-C
[100.530235] Dynamic subtest pipe-C: SUCCESS (1.111s)
[100.539692] Starting dynamic subtest: pipe-D
[101.684436] Dynamic subtest pipe-D: SUCCESS (1.153s)
[101.685532] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.456s)
[102.832728] [017/133] (917s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[102.926895] Starting subtest: bad-rotation-90-yf-tiled-ccs
[102.927867] Starting dynamic subtest: pipe-A-eDP-1
[102.936483] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[102.943688] Starting dynamic subtest: pipe-B-eDP-1
[102.952205] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[102.959036] Starting dynamic subtest: pipe-C-eDP-1
[102.967118] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[102.973801] Starting dynamic subtest: pipe-D-eDP-1
[102.981402] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[102.983071] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[105.099075] [018/133] (915s left) gem_ctx_exec (basic)
[105.148380] Starting subtest: basic
[105.156108] Subtest basic: SUCCESS (0.008s)
[105.280935] [019/133] (915s left) gem_exec_schedule (pi-shared-iova)
[105.468460] Starting subtest: pi-shared-iova
[105.469282] Starting dynamic subtest: rcs0
[105.537402] Dynamic subtest rcs0: SUCCESS (0.076s)
[105.547842] Starting dynamic subtest: vcs0
[105.593488] Dynamic subtest vcs0: SUCCESS (0.054s)
[105.602642] Starting dynamic subtest: vcs1
[105.647023] Dynamic subtest vcs1: SUCCESS (0.053s)
[105.655378] Starting dynamic subtest: vecs0
[105.700529] Dynamic subtest vecs0: SUCCESS (0.053s)
[105.708826] Starting dynamic subtest: ccs0
[105.760397] Dynamic subtest ccs0: SUCCESS (0.059s)
[105.761965] Subtest pi-shared-iova: SUCCESS (0.299s)
[107.383904] [020/133] (913s left) device_reset (unbind-reset-rebind)
[107.429232] Starting subtest: unbind-reset-rebind
[112.365023] Subtest unbind-reset-rebind: SUCCESS (4.923s)
[112.395948] [021/133] (908s left) syncobj_timeline (wait-all-snapshot)
[112.452865] Starting subtest: wait-all-snapshot
[112.535972] Subtest wait-all-snapshot: SUCCESS (0.082s)
[112.609083] [022/133] (908s left) gem_mmap_gtt (medium-copy-xy)
[112.658347] Subtest medium-copy-XY: SKIP (0.000s)
[112.707796] [023/133] (908s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[112.761749] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[112.762843] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[112.848342] [024/133] (908s left) perf_pmu (busy-check-all)
[112.882147] Starting subtest: busy-check-all
[112.883617] Starting dynamic subtest: rcs0
[113.446382] Dynamic subtest rcs0: SUCCESS (0.564s)
[113.461079] Starting dynamic subtest: bcs0
[114.000670] Dynamic subtest bcs0: SUCCESS (0.552s)
[114.016056] Starting dynamic subtest: vcs0
[115.300738] Dynamic subtest vcs0: SUCCESS (1.289s)
[115.311382] Starting dynamic subtest: vcs1
[117.346908] Dynamic subtest vcs1: SUCCESS (2.044s)
[117.357423] Starting dynamic subtest: vecs0
[119.332066] Dynamic subtest vecs0: SUCCESS (1.983s)
[119.342533] Starting dynamic subtest: ccs0
[119.881269] Dynamic subtest ccs0: SUCCESS (0.556s)
[119.882644] Subtest busy-check-all: SUCCESS (6.999s)
[119.965588] [025/133] (900s left) syncobj_timeline (invalid-query-illegal-handle)
[120.018340] Starting subtest: invalid-query-illegal-handle
[120.019291] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[120.108660] [026/133] (900s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[120.219664] Starting subtest: cursorA-vs-flipA-atomic-transitions
[131.428846] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.202s)
[132.225525] [027/133] (888s left) gem_tiled_swapping (non-threaded)
[132.285033] Subtest non-threaded: SKIP (0.000s)
[132.343326] [028/133] (888s left) kms_plane_multiple (tiling-x)
[132.427116] Starting subtest: tiling-x
[132.427883] Starting dynamic subtest: pipe-A-eDP-1
[136.263655] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.835s)
[136.272328] Starting dynamic subtest: pipe-B-eDP-1
[140.682660] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.418s)
[140.691493] Starting dynamic subtest: pipe-C-eDP-1
[145.123282] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.439s)
[145.131474] Starting dynamic subtest: pipe-D-eDP-1
[149.447447] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.322s)
[149.448758] Subtest tiling-x: SUCCESS (17.020s)
[150.260561] [029/133] (870s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[150.353908] Starting subtest: yf-tiled-16bpp-rotate-270
[150.356069] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[150.446086] [030/133] (870s left) kms_psr (pr-cursor-mmap-cpu)
[150.535594] Starting subtest: pr-cursor-mmap-cpu
[150.537463] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[150.615971] [031/133] (870s left) gem_ctx_param (invalid-get-ringsize)
[150.661602] Starting subtest: invalid-get-ringsize
[150.662584] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[150.755259] [032/133] (870s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[150.840294] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[157.646207] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.807s)
[157.791429] [033/133] (863s left) gem_exec_whisper (basic-fds-all)
[157.848838] Starting subtest: basic-fds-all
[168.950200] Subtest basic-fds-all: SUCCESS (11.100s)
[169.131600] [034/133] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[169.227174] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[169.229072] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[169.315967] [035/133] (851s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[169.377306] Starting subtest: invalid-multi-wait-unsubmitted
[169.378289] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[169.474468] [036/133] (851s left) gem_mmap_offset (close-race)
[169.530055] Starting subtest: close-race
[189.683774] Subtest close-race: SUCCESS (20.109s)
[189.774483] [037/133] (831s left) kms_psr (psr-cursor-render)
[189.855325] Starting subtest: psr-cursor-render
[189.856199] Starting dynamic subtest: eDP-1
[191.592698] Dynamic subtest eDP-1: SUCCESS (1.736s)
[191.593603] Subtest psr-cursor-render: SUCCESS (1.737s)
[192.467462] [038/133] (828s left) perf_pmu (interrupts)
[192.502172] Starting subtest: interrupts
[193.599427] Subtest interrupts: SUCCESS (1.088s)
[193.690451] [039/133] (827s left) api_intel_allocator (alloc-simple)
[193.750951] Starting subtest: alloc-simple
[193.755022] Subtest alloc-simple: SUCCESS (0.004s)
[193.882095] [040/133] (827s left) kms_psr (psr-primary-blt)
[193.969403] Starting subtest: psr-primary-blt
[193.970250] Starting dynamic subtest: eDP-1
[195.676452] Dynamic subtest eDP-1: SUCCESS (1.704s)
[195.677544] Subtest psr-primary-blt: SUCCESS (1.705s)
[196.542984] [041/133] (824s left) kms_cursor_crc (cursor-random-512x170)
[196.831933] Starting subtest: cursor-random-512x170
[196.834244] Subtest cursor-random-512x170: SKIP (0.001s)
[196.968742] [042/133] (824s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[197.020431] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[197.127033] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[197.211401] [043/133] (824s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[199.441737] Starting subtest: gem-execbuf-stress-pc8
[199.481790] Subtest gem-execbuf-stress-pc8: SKIP (0.039s)
[199.824138] [044/133] (821s left) gem_reg_read (bad-register)
[199.865294] Starting subtest: bad-register
[199.866178] Subtest bad-register: SUCCESS (0.000s)
[199.951643] [045/133] (821s left) gem_mmap_gtt (basic-small-copy-odd)
[199.994747] Subtest basic-small-copy-odd: SKIP (0.000s)
[200.048069] [046/133] (821s left) i915_hangman (gt-engine-hang)
[200.111026] Starting subtest: gt-engine-hang
[200.111948] Starting dynamic subtest: rcs0
[201.281847] Dynamic subtest rcs0: SUCCESS (1.162s)
[201.293665] Starting dynamic subtest: bcs0
[203.265043] Dynamic subtest bcs0: SUCCESS (1.980s)
[203.277452] Starting dynamic subtest: vcs0
[205.314716] Dynamic subtest vcs0: SUCCESS (2.046s)
[205.330655] Starting dynamic subtest: vcs1
[207.297444] Dynamic subtest vcs1: SUCCESS (1.979s)
[207.311371] Starting dynamic subtest: vecs0
[209.281355] Dynamic subtest vecs0: SUCCESS (1.981s)
[209.298411] Starting dynamic subtest: ccs0
[211.265945] Dynamic subtest ccs0: SUCCESS (1.982s)
[211.267828] Subtest gt-engine-hang: SUCCESS (11.148s)
[211.336588] [047/133] (810s left) fbdev (pan)
[211.366031] Starting subtest: pan
[211.393907] Subtest pan: SUCCESS (0.028s)
[211.461567] [048/133] (810s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[211.554422] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[212.272221] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.502s)
[212.303866] [049/133] (809s left) prime_self_import (basic-with_one_bo)
[212.335476] Starting subtest: basic-with_one_bo
[212.348949] Subtest basic-with_one_bo: SUCCESS (0.014s)
[212.471172] [050/133] (809s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[212.556295] Starting subtest: 2x-flip-vs-modeset-vs-hang
[212.558016] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.002s)
[212.666596] [051/133] (809s left) kms_flip (2x-flip-vs-suspend)
[212.762272] Starting subtest: 2x-flip-vs-suspend
[212.764131] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[212.861964] [052/133] (809s left) i915_query (query-garbage)
[212.907771] Starting subtest: query-garbage
[212.909152] Subtest query-garbage: SUCCESS (0.000s)
[212.994450] [053/133] (808s left) kms_pm_dc (dc5-retention-flops)
[214.107605] Starting subtest: dc5-retention-flops
[214.109291] Subtest dc5-retention-flops: SKIP (0.000s)
[214.189642] [054/133] (807s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[214.283733] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[214.285741] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[214.383032] [055/133] (807s left) kms_atomic_interruptible (legacy-dpms)
[214.473521] Starting subtest: legacy-dpms
[214.474433] Starting dynamic subtest: pipe-A-eDP-1
[221.845656] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.372s)
[221.846520] Subtest legacy-dpms: SUCCESS (7.373s)
[222.692220] [056/133] (799s left) gem_basic (create-close)
[222.737215] Starting subtest: create-close
[222.739038] Subtest create-close: SUCCESS (0.000s)
[222.848826] [057/133] (799s left) sysfs_timeslice_duration (idempotent)
[222.900435] Starting subtest: idempotent
[222.901650] Starting dynamic subtest: vecs0
[222.902666] Dynamic subtest vecs0: SUCCESS (0.000s)
[222.913111] Starting dynamic subtest: ccs0
[222.913889] Dynamic subtest ccs0: SUCCESS (0.000s)
[222.922812] Starting dynamic subtest: vcs0
[222.923645] Dynamic subtest vcs0: SUCCESS (0.000s)
[222.932189] Starting dynamic subtest: bcs0
[222.933348] Dynamic subtest bcs0: SUCCESS (0.000s)
[222.941741] Starting dynamic subtest: rcs0
[222.942597] Dynamic subtest rcs0: SUCCESS (0.000s)
[222.951094] Starting dynamic subtest: vcs1
[222.952066] Dynamic subtest vcs1: SUCCESS (0.000s)
[222.953105] Subtest idempotent: SUCCESS (0.006s)
[223.020536] [058/133] (799s left) kms_cursor_crc (cursor-offscreen-128x128)
[223.212458] Starting subtest: cursor-offscreen-128x128
[223.217711] Starting dynamic subtest: pipe-A-eDP-1
[225.136278] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.919s)
[225.167594] Starting dynamic subtest: pipe-D-eDP-1
[227.786629] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.627s)
[227.788363] Subtest cursor-offscreen-128x128: SUCCESS (4.574s)
[228.637074] [059/133] (793s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[228.730529] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[228.732325] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[228.830799] [060/133] (793s left) gem_pxp (regular-baseline-src-copy-readible)
[228.944965] Starting subtest: regular-baseline-src-copy-readible
[229.003092] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[229.128744] [061/133] (793s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[229.216966] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[229.218846] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[229.284896] [062/133] (792s left) gem_exec_schedule (fairslice)
[229.363145] Starting subtest: fairslice
[229.363953] Starting dynamic subtest: rcs0
[231.390884] Dynamic subtest rcs0: SUCCESS (2.024s)
[231.401993] Starting dynamic subtest: bcs0
[233.411055] Dynamic subtest bcs0: SUCCESS (2.020s)
[233.419792] Starting dynamic subtest: vcs0
[235.432899] Dynamic subtest vcs0: SUCCESS (2.019s)
[235.442311] Starting dynamic subtest: vcs1
[237.454921] Dynamic subtest vcs1: SUCCESS (2.019s)
[237.463565] Starting dynamic subtest: vecs0
[239.464705] Dynamic subtest vecs0: SUCCESS (2.014s)
[239.475358] Starting dynamic subtest: ccs0
[241.491365] Dynamic subtest ccs0: SUCCESS (2.020s)
[241.492401] Subtest fairslice: SUCCESS (12.123s)
[241.777158] [063/133] (780s left) kms_frontbuffer_tracking (psr-2p-rte)
[241.881239] Starting subtest: psr-2p-rte
[241.883060] Subtest psr-2p-rte: SKIP (0.000s)
[241.977334] [064/133] (780s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[242.063832] Starting subtest: plane-lut1d-pre-ctm3x4
[242.232149] Starting dynamic subtest: pipe-A-plane-0
[242.432160] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[242.441441] Starting dynamic subtest: pipe-A-plane-1
[242.587478] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[242.596767] Starting dynamic subtest: pipe-A-plane-2
[242.776547] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[243.962953] Starting dynamic subtest: pipe-B-plane-0
[244.130470] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[244.140767] Starting dynamic subtest: pipe-B-plane-1
[244.319941] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[244.330537] Starting dynamic subtest: pipe-B-plane-2
[244.508545] Dynamic subtest pipe-B-plane-2: SUCCESS (0.187s)
[245.701544] Starting dynamic subtest: pipe-C-plane-0
[245.837190] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[245.849437] Starting dynamic subtest: pipe-C-plane-1
[245.992709] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[246.003736] Starting dynamic subtest: pipe-C-plane-2
[246.159507] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[247.332481] Starting dynamic subtest: pipe-D-plane-0
[247.489970] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[247.499898] Starting dynamic subtest: pipe-D-plane-1
[247.656747] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[247.666211] Starting dynamic subtest: pipe-D-plane-2
[247.823077] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[248.109771] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.048s)
[248.983416] [065/133] (773s left) gem_exec_balancer (semaphore)
[249.035612] Starting subtest: semaphore
[250.332038] Subtest semaphore: SUCCESS (1.287s)
[250.635690] [066/133] (771s left) kms_content_protection (dp-mst-type-0)
[250.784653] Starting subtest: dp-mst-type-0
[250.786576] Subtest dp-mst-type-0: SKIP (0.000s)
[250.902194] [067/133] (771s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[250.992169] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[250.994040] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[251.086095] [068/133] (771s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[251.213848] Starting subtest: 2x-flip-vs-cursor-atomic
[251.216558] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[251.368401] [069/133] (771s left) kms_lease (lease-invalid-crtc)
[251.469752] Starting subtest: lease-invalid-crtc
[251.470753] Starting dynamic subtest: pipe-A-eDP-1
[251.471702] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[251.481635] Starting dynamic subtest: pipe-B-eDP-1
[251.482540] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[251.493987] Starting dynamic subtest: pipe-C-eDP-1
[251.494832] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[251.503959] Starting dynamic subtest: pipe-D-eDP-1
[251.504941] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[251.505729] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[251.539454] [070/133] (770s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[251.665511] Starting subtest: cursor-vs-flip-atomic-transitions
[282.137228] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.469s)
[283.019228] [071/133] (739s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[283.075181] Starting subtest: yf-tiled-to-vebox-y-tiled
[283.076838] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[283.256178] [072/133] (739s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[283.343463] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[283.344345] Starting dynamic subtest: pipe-A-default-mode
[284.501023] Dynamic subtest pipe-A-default-mode: SKIP (1.156s)
[284.502937] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.158s)
[284.655572] [073/133] (737s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[284.700265] Starting subtest: etime-single-wait-available-unsubmitted
[284.806922] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s)
[284.879470] [074/133] (737s left) kms_chamelium_color (ctm-0-50)
[284.974183] Subtest ctm-0-50: SKIP (0.000s)
[285.014924] [075/133] (737s left) kms_invalid_mode (overflow-vrefresh)
[285.114163] Starting subtest: overflow-vrefresh
[285.115030] Starting dynamic subtest: pipe-A-eDP-1
[285.424259] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.310s)
[285.435379] Starting dynamic subtest: pipe-B-eDP-1
[285.436457] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[285.445076] Starting dynamic subtest: pipe-C-eDP-1
[285.445930] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[285.454740] Starting dynamic subtest: pipe-D-eDP-1
[285.455755] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[285.456778] Subtest overflow-vrefresh: SUCCESS (0.317s)
[286.300781] [076/133] (736s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[286.397381] Starting subtest: psr-1p-primscrn-spr-indfb-move
[293.863183] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.466s)
[293.985391] [077/133] (728s left) gem_create (hog-create)
[294.042417] Starting subtest: hog-create
[294.043483] Starting dynamic subtest: smem0
[326.359803] Dynamic subtest smem0: SUCCESS (32.314s)
[326.361049] Subtest hog-create: SUCCESS (32.316s)
[326.558441] [078/133] (696s left) gem_unref_active_buffers
[326.753452] [079/133] (696s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[326.856032] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[326.858111] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[326.953657] [080/133] (695s left) kms_big_fb (y-tiled-addfb-size-overflow)
[327.049213] Starting subtest: y-tiled-addfb-size-overflow
[327.050921] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[327.148763] [081/133] (695s left) gem_exec_reloc (basic-write-cpu-active)
[327.204787] Subtest basic-write-cpu-active: SKIP (0.000s)
[327.279626] [082/133] (695s left) kms_pm_rpm (legacy-planes-dpms)
[329.497997] Starting subtest: legacy-planes-dpms
[329.499162] Starting dynamic subtest: plane-65
[337.808678] Dynamic subtest plane-65: SUCCESS (8.310s)
[337.819530] Starting dynamic subtest: plane-95
[346.238613] Dynamic subtest plane-95: SUCCESS (8.417s)
[346.250214] Starting dynamic subtest: plane-125
[354.971391] Dynamic subtest plane-125: SUCCESS (8.739s)
[354.983861] Starting dynamic subtest: plane-135
[363.284694] Dynamic subtest plane-135: SUCCESS (8.311s)
[363.287779] Subtest legacy-planes-dpms: SUCCESS (33.787s)
[363.666674] [083/133] (659s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[363.751421] Starting subtest: disable-crc-after-crtc
[363.752252] Starting dynamic subtest: pipe-A-eDP-1
[365.419795] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.669s)
[365.428335] Starting dynamic subtest: pipe-B-eDP-1
[367.691064] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.269s)
[367.702377] Starting dynamic subtest: pipe-C-eDP-1
[369.947686] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.255s)
[369.957234] Starting dynamic subtest: pipe-D-eDP-1
[372.218735] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.271s)
[372.219647] Subtest disable-crc-after-crtc: SUCCESS (8.468s)
[373.037799] [084/133] (649s left) prime_udl
[373.114027] [085/133] (649s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[373.213513] Starting subtest: fbcpsr-modesetfrombusy
[379.426212] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.213s)
[379.559869] [086/133] (643s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[379.669697] Starting subtest: x-tiled-8bpp-rotate-270
[379.695537] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s)
[379.804539] [087/133] (643s left) gem_exec_fence (syncobj-repeat)
[380.261434] Starting subtest: syncobj-repeat
[380.471586] Subtest syncobj-repeat: SUCCESS (0.201s)
[381.410039] [088/133] (641s left) gem_softpin (zero)
[381.465755] Starting subtest: zero
[381.469590] Subtest zero: SUCCESS (0.004s)
[381.588628] [089/133] (641s left) gem_ctx_persistence (heartbeat-hostile)
[381.650900] Starting subtest: heartbeat-hostile
[381.653473] Subtest heartbeat-hostile: SKIP (0.000s)
[381.761655] [090/133] (641s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[381.855445] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[381.857225] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[381.943894] [091/133] (641s left) kms_chamelium_frames (hdmi-crc-multiple)
[382.328258] Subtest hdmi-crc-multiple: SKIP (0.000s)
[383.108674] [092/133] (640s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[383.191941] Starting subtest: async-flip-with-page-flip-events-linear
[383.565265] Starting dynamic subtest: pipe-A-eDP-1
[386.313428] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.738s)
[386.667840] Starting dynamic subtest: pipe-B-eDP-1
[389.443927] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.774s)
[389.799236] Starting dynamic subtest: pipe-C-eDP-1
[392.578238] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.776s)
[392.930284] Starting dynamic subtest: pipe-D-eDP-1
[395.710072] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s)
[395.711294] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.509s)
[396.884410] [093/133] (626s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[396.983948] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[396.985840] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[397.052713] [094/133] (626s left) gem_exec_params (secure-non-master)
[397.100370] Starting subtest: secure-non-master
[397.102159] Subtest secure-non-master: SKIP (0.000s)
[397.192680] [095/133] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[397.287647] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[397.289536] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[397.375384] [096/133] (626s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[397.459897] Starting subtest: fbc-rgb101010-draw-render
[402.091489] Subtest fbc-rgb101010-draw-render: SUCCESS (4.631s)
[403.279832] [097/133] (620s left) api_intel_bb (reset-flags)
[403.334808] Starting subtest: reset-flags
[403.341549] Subtest reset-flags: SUCCESS (0.008s)
[403.445644] [098/133] (620s left) syncobj_wait (single-wait-submitted)
[403.494079] Starting subtest: single-wait-submitted
[403.599042] Subtest single-wait-submitted: SUCCESS (0.104s)
[403.683697] [099/133] (619s left) i915_query (engine-info)
[403.739451] Starting subtest: engine-info
[403.742620] Subtest engine-info: SUCCESS (0.005s)
[403.865812] [100/133] (619s left) perf_pmu (all-busy-check-all)
[403.898494] Starting subtest: all-busy-check-all
[405.347552] Subtest all-busy-check-all: SUCCESS (1.439s)
[405.435144] [101/133] (618s left) syncobj_basic (bad-flags-fd-to-handle)
[405.482042] Starting subtest: bad-flags-fd-to-handle
[405.483164] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[405.571365] [102/133] (618s left) gem_exec_schedule (u-submit-golden-slice)
[405.628152] Starting subtest: u-submit-golden-slice
[405.628997] Starting dynamic subtest: rcs0
[405.664772] Dynamic subtest rcs0: SUCCESS (0.036s)
[405.674309] Starting dynamic subtest: bcs0
[405.691258] Dynamic subtest bcs0: SUCCESS (0.026s)
[405.701073] Starting dynamic subtest: vcs0
[405.724634] Dynamic subtest vcs0: SUCCESS (0.033s)
[405.735275] Starting dynamic subtest: vcs1
[405.761987] Dynamic subtest vcs1: SUCCESS (0.037s)
[405.772862] Starting dynamic subtest: vecs0
[405.803752] Dynamic subtest vecs0: SUCCESS (0.040s)
[405.814628] Starting dynamic subtest: ccs0
[405.863451] Dynamic subtest ccs0: SUCCESS (0.058s)
[405.864430] Subtest u-submit-golden-slice: SUCCESS (0.235s)
[407.416212] [103/133] (616s left) i915_drm_fdinfo (memory-info-shared)
[407.451779] Starting subtest: memory-info-shared
[407.452645] Starting dynamic subtest: smem0
[407.504381] Dynamic subtest smem0: SUCCESS (0.051s)
[407.505740] Subtest memory-info-shared: SUCCESS (0.052s)
[407.574905] [104/133] (616s left) gem_mmap_wc (write-read-distinct)
[407.622891] Subtest write-read-distinct: SKIP (0.000s)
[407.688875] [105/133] (616s left) kms_selftest (drm_damage_helper)
[407.718673] Starting subtest: drm_damage_helper
[407.731700] Starting dynamic subtest: drm_test_damage_iter_no_damage
[407.809617] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.079s)
[407.820169] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[407.910928] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.101s)
[407.921613] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[408.010041] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.097s)
[408.019702] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[408.096254] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.086s)
[408.105206] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[408.192725] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.096s)
[408.202360] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[408.287952] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.094s)
[408.303206] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[408.373716] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.085s)
[408.383690] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[408.459499] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.085s)
[408.470494] Starting dynamic subtest: drm_test_damage_iter_single_damage
[408.553559] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.094s)
[408.563921] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[408.646902] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.092s)
[408.658096] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[408.735545] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.087s)
[408.746086] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[408.833452] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.096s)
[408.845294] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[408.927621] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.092s)
[408.937946] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[409.021708] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.092s)
[409.030592] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[409.116253] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.094s)
[409.127029] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[409.210646] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.094s)
[409.221090] Starting dynamic subtest: drm_test_damage_iter_damage
[409.309699] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.098s)
[409.320967] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[409.397373] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.086s)
[409.406689] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[409.485881] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.088s)
[409.497337] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[409.573301] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.084s)
[409.582053] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[409.658108] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.085s)
[409.659049] Subtest drm_damage_helper: SUCCESS (1.939s)
[409.801123] [106/133] (613s left) prime_mmap (test_correct_cpu_write)
[409.841552] Starting subtest: test_correct_cpu_write
[409.842639] Starting dynamic subtest: test_correct_cpu_write-smem
[409.843707] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[409.844772] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[409.932544] [107/133] (613s left) gen9_exec_parse (secure-batches)
[409.989281] Subtest secure-batches: SKIP (0.000s)
[410.054964] [108/133] (613s left) kms_atomic (plane-immutable-zpos)
[410.157089] Starting subtest: plane-immutable-zpos
[410.159226] Starting dynamic subtest: pipe-A-eDP-1
[410.798475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.638s)
[410.799626] Subtest plane-immutable-zpos: SUCCESS (0.641s)
[411.605979] [109/133] (612s left) gem_exec_nop (basic-parallel)
[411.666843] Starting subtest: basic-parallel
[427.300811] Subtest basic-parallel: SUCCESS (15.626s)
[427.521053] [110/133] (596s left) kms_psr (fbc-psr-sprite-render)
[427.622445] Starting subtest: fbc-psr-sprite-render
[427.623400] Starting dynamic subtest: eDP-1
[427.625357] Dynamic subtest eDP-1: SKIP (0.000s)
[427.626972] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[427.690566] [111/133] (596s left) gem_fenced_exec_thrash (2-spare-fences)
[427.739720] Subtest 2-spare-fences: SKIP (0.000s)
[427.803313] [112/133] (596s left) perf_pmu (idle)
[427.836659] Starting subtest: idle
[427.838290] Starting dynamic subtest: rcs0
[428.386049] Dynamic subtest rcs0: SUCCESS (0.539s)
[428.395893] Starting dynamic subtest: bcs0
[428.907268] Dynamic subtest bcs0: SUCCESS (0.515s)
[428.918349] Starting dynamic subtest: vcs0
[429.423918] Dynamic subtest vcs0: SUCCESS (0.516s)
[429.435862] Starting dynamic subtest: vcs1
[429.940980] Dynamic subtest vcs1: SUCCESS (0.513s)
[429.952370] Starting dynamic subtest: vecs0
[430.459201] Dynamic subtest vecs0: SUCCESS (0.516s)
[430.470839] Starting dynamic subtest: ccs0
[430.987362] Dynamic subtest ccs0: SUCCESS (0.526s)
[430.988751] Subtest idle: SUCCESS (3.142s)
[431.109835] [113/133] (592s left) kms_vblank (wait-busy-hang)
[431.204045] Starting subtest: wait-busy-hang
[431.204868] Starting dynamic subtest: pipe-A-eDP-1
[458.083892] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.877s)
[458.095358] Starting dynamic subtest: pipe-D-eDP-1
[473.126124] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.040s)
[473.127063] Subtest wait-busy-hang: SUCCESS (41.921s)
[473.959810] [114/133] (550s left) gem_exec_balancer (noheartbeat)
[474.219464] Starting subtest: noheartbeat
[474.221534] Subtest noheartbeat: SKIP (0.000s)
[474.302950] [115/133] (549s left) kms_hdr (brightness-with-hdr)
[474.399511] Starting subtest: brightness-with-hdr
[474.402463] Subtest brightness-with-hdr: SKIP (0.000s)
[474.480864] [116/133] (549s left) kms_flip (blocking-wf_vblank)
[474.580395] Starting subtest: blocking-wf_vblank
[474.581509] Starting dynamic subtest: A-eDP1
[483.541624] Dynamic subtest A-eDP1: SUCCESS (8.936s)
[483.554709] Starting dynamic subtest: B-eDP1
[492.484574] Dynamic subtest B-eDP1: SUCCESS (8.940s)
[492.494231] Starting dynamic subtest: C-eDP1
[501.429146] Dynamic subtest C-eDP1: SUCCESS (8.929s)
[501.439636] Starting dynamic subtest: D-eDP1
[510.364085] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[510.365530] Subtest blocking-wf_vblank: SUCCESS (35.753s)
[511.552982] [117/133] (512s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[511.645539] Starting subtest: pixel-format-linear-modifier-source-clamping
[511.673086] Starting dynamic subtest: pipe-A-plane-0
[512.261783] Dynamic subtest pipe-A-plane-0: SUCCESS (0.589s)
[512.271435] Starting dynamic subtest: pipe-A-plane-3
[512.684042] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s)
[513.745949] Starting dynamic subtest: pipe-B-plane-0
[514.347691] Dynamic subtest pipe-B-plane-0: SUCCESS (0.611s)
[514.356847] Starting dynamic subtest: pipe-B-plane-3
[514.803353] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s)
[515.116215] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.470s)
[515.915466] [118/133] (508s left) gem_lmem_swapping (heavy-verify-multi)
[515.951016] Subtest heavy-verify-multi: SKIP (0.000s)
[515.987117] [119/133] (508s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[516.081574] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[520.674576] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.592s)
[521.828745] [120/133] (502s left) kms_big_fb (4-tiled-addfb-size-overflow)
[521.936680] Starting subtest: 4-tiled-addfb-size-overflow
[521.937603] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[522.039188] [121/133] (502s left) gem_vm_create (invalid-create)
[522.089816] Starting subtest: invalid-create
[522.092143] Subtest invalid-create: SUCCESS (0.002s)
[522.206197] [122/133] (502s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[522.290477] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[522.291431] Starting dynamic subtest: pipe-A-eDP-1
[522.300499] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[522.309776] Starting dynamic subtest: pipe-B-eDP-1
[522.318646] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[522.327766] Starting dynamic subtest: pipe-C-eDP-1
[522.336236] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[522.345321] Starting dynamic subtest: pipe-D-eDP-1
[522.354136] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[522.355760] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[524.467395] [123/133] (499s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[524.561867] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[531.679974] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.118s)
[531.800442] [124/133] (492s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[531.891398] Starting subtest: fbc-psr2-cursor-mmap-cpu
[531.892284] Starting dynamic subtest: eDP-1
[531.894158] Dynamic subtest eDP-1: SKIP (0.000s)
[531.896057] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[531.965714] [125/133] (492s left) syncobj_basic (bad-create-flags)
[532.024289] Starting subtest: bad-create-flags
[532.025376] Subtest bad-create-flags: SUCCESS (0.000s)
[532.132469] [126/133] (492s left) perf (enable-disable)
[532.246483] Starting subtest: enable-disable
[532.247418] Starting dynamic subtest: 0-rcs0
[534.523949] Dynamic subtest 0-rcs0: SUCCESS (2.267s)
[534.536077] Starting dynamic subtest: 1-vcs1
[539.052881] Dynamic subtest 1-vcs1: SUCCESS (4.491s)
[539.054458] Subtest enable-disable: SUCCESS (6.760s)
[539.086213] [127/133] (485s left) gem_ctx_shared (q-smoketest)
[539.151664] Starting subtest: Q-smoketest
[539.153294] Starting dynamic subtest: rcs0
[544.732295] Dynamic subtest rcs0: SUCCESS (5.513s)
[544.743216] Starting dynamic subtest: bcs0
[550.206096] Dynamic subtest bcs0: SUCCESS (5.473s)
[550.218821] Starting dynamic subtest: vcs0
[555.680111] Dynamic subtest vcs0: SUCCESS (5.470s)
[555.692935] Starting dynamic subtest: vcs1
[561.162865] Dynamic subtest vcs1: SUCCESS (5.483s)
[561.176831] Starting dynamic subtest: vecs0
[566.637336] Dynamic subtest vecs0: SUCCESS (5.471s)
[566.653070] Starting dynamic subtest: ccs0
[572.100083] Dynamic subtest ccs0: SUCCESS (5.501s)
[572.100893] Subtest Q-smoketest: SUCCESS (32.919s)
[572.257152] [128/133] (452s left) gem_exec_flush (basic-wb-rw-before-default)
[572.316203] Starting subtest: basic-wb-rw-before-default
[577.782449] Subtest basic-wb-rw-before-default: SUCCESS (5.466s)
[577.970986] [129/133] (446s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[578.060423] Starting subtest: psr-rgb565-draw-mmap-wc
[585.001343] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.942s)
[585.125128] [130/133] (439s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[585.229555] Starting subtest: crc-primary-basic-yf-tiled-ccs
[585.230352] Starting dynamic subtest: pipe-A-eDP-1
[585.238420] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[585.248714] Starting dynamic subtest: pipe-B-eDP-1
[585.256924] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[585.266017] Starting dynamic subtest: pipe-C-eDP-1
[585.273879] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[585.282617] Starting dynamic subtest: pipe-D-eDP-1
[585.290687] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[585.292350] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[587.487958] [131/133] (437s left) kms_cursor_legacy (forked-move)
[587.636531] Starting subtest: forked-move
[587.637511] Starting dynamic subtest: pipe-A
[593.154080] Dynamic subtest pipe-A: SUCCESS (5.470s)
[593.166492] Starting dynamic subtest: pipe-B
[598.640117] Dynamic subtest pipe-B: SUCCESS (5.483s)
[598.651689] Starting dynamic subtest: pipe-C
[604.114095] Dynamic subtest pipe-C: SUCCESS (5.471s)
[604.125053] Starting dynamic subtest: pipe-D
[609.587803] Dynamic subtest pipe-D: SUCCESS (5.470s)
[609.601417] Starting dynamic subtest: all-pipes
[615.054409] Dynamic subtest all-pipes: SUCCESS (5.501s)
[615.055833] Subtest forked-move: SUCCESS (27.408s)
[615.187679] [132/133] (409s left) prime_vgem (fence-wait)
[615.272496] Starting subtest: fence-wait
[615.273416] Starting dynamic subtest: rcs0
[616.348511] Dynamic subtest rcs0: SUCCESS (1.068s)
[616.358248] Starting dynamic subtest: bcs0
[617.408106] Dynamic subtest bcs0: SUCCESS (1.059s)
[617.417619] Starting dynamic subtest: vcs0
[618.451444] Dynamic subtest vcs0: SUCCESS (1.042s)
[618.463778] Starting dynamic subtest: vcs1
[619.494703] Dynamic subtest vcs1: SUCCESS (1.042s)
[619.506504] Starting dynamic subtest: vecs0
[620.534748] Dynamic subtest vecs0: SUCCESS (1.039s)
[620.546506] Starting dynamic subtest: ccs0
[621.580048] Dynamic subtest ccs0: SUCCESS (1.043s)
[621.581230] Subtest fence-wait: SUCCESS (6.301s)
[621.705189] [133/133] (403s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[621.813385] Starting subtest: 2x-absolute-wf_vblank-interruptible
[621.825681] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[621.897454] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: gem_mmap_wc
results: parsing output: 6/ for test: kms_dsc
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: gem_pxp
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_cursor_edge_walk
results: parsing output: 14/ for test: vgem_basic
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_ctx_exec
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: device_reset
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: gem_tiled_swapping
results: parsing output: 27/ for test: kms_plane_multiple
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_ctx_param
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_mmap_offset
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: api_intel_allocator
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: i915_pm_rpm
results: parsing output: 43/ for test: gem_reg_read
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: i915_hangman
results: parsing output: 46/ for test: fbdev
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: prime_self_import
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: i915_query
results: parsing output: 52/ for test: kms_pm_dc
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_atomic_interruptible
results: parsing output: 55/ for test: gem_basic
results: parsing output: 56/ for test: sysfs_timeslice_duration
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_color_pipeline
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: kms_content_protection
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_chamelium_color
results: parsing output: 74/ for test: kms_invalid_mode
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_create
results: parsing output: 77/ for test: gem_unref_active_buffers
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_pm_rpm
results: parsing output: 82/ for test: kms_pipe_crc_basic
results: parsing output: 83/ for test: prime_udl
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: gem_softpin
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_chamelium_frames
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: i915_query
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: i915_drm_fdinfo
results: parsing output: 103/ for test: gem_mmap_wc
results: parsing output: 104/ for test: kms_selftest
results: parsing output: 105/ for test: prime_mmap
results: parsing output: 106/ for test: gen9_exec_parse
results: parsing output: 107/ for test: kms_atomic
results: parsing output: 108/ for test: gem_exec_nop
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_fenced_exec_thrash
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_vblank
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: kms_hdr
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_vm_create
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: syncobj_basic
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: gem_ctx_shared
results: parsing output: 127/ for test: gem_exec_flush
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: prime_vgem
results: parsing output: 132/ for test: kms_flip
Done.