[58.372032] Initializing watchdogs
[58.372085]   /dev/watchdog0
[58.386809] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.390955] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.392916] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.396558] [001/133] (960s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[58.500194] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[58.505130] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[58.566487] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-y)
[58.625087] Subtest fault-concurrent-Y: SKIP (0.000s)
[58.677623] [003/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[58.766115] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[58.770471] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[58.871713] [004/133] (960s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[59.253182] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[60.075246] [005/133] (958s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[60.154675] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[60.156831] Starting dynamic subtest: pipe-A-eDP-1
[61.439687] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.285s)
[61.723779] Starting dynamic subtest: pipe-B-eDP-1
[62.763810] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.047s)
[63.031325] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.876s)
[63.878725] [006/133] (955s left) gem_mmap_wc (read)
[63.924841] Subtest read: SKIP (0.000s)
[63.981830] [007/133] (955s left) kms_dsc (dsc-basic)
[64.061943] Starting subtest: dsc-basic
[64.074976] Subtest dsc-basic: SKIP (0.000s)
[64.133429] [008/133] (955s left) kms_addfb_basic (unused-offsets)
[64.187631] Starting subtest: unused-offsets
[64.189559] Subtest unused-offsets: SUCCESS (0.000s)
[64.307561] [009/133] (954s left) gem_pxp (create-valid-protected-context)
[64.435298] Starting subtest: create-valid-protected-context
[64.438103] Subtest create-valid-protected-context: SUCCESS (0.004s)
[64.541443] [010/133] (954s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[64.604694] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[64.607314] Starting dynamic subtest: pipe-A-eDP-1
[65.511803] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.901s)
[65.520466] Starting dynamic subtest: pipe-B-eDP-1
[67.092615] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.577s)
[67.101999] Starting dynamic subtest: pipe-C-eDP-1
[68.604874] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.511s)
[68.615242] Starting dynamic subtest: pipe-D-eDP-1
[70.150525] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.547s)
[70.152490] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.539s)
[71.312187] [011/133] (947s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[71.394622] Starting subtest: fbcpsr-stridechange
[77.615040] Subtest fbcpsr-stridechange: SUCCESS (6.223s)
[77.738162] [012/133] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[77.815149] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[77.819313] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[77.906515] [013/133] (941s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[77.979911] Starting subtest: psr2-plane-move-sf-dmg-area
[77.982473] Starting dynamic subtest: pipe-A-eDP-1
[82.483988] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.509s)
[82.496224] Starting dynamic subtest: pipe-B-eDP-1
[87.815026] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.328s)
[87.817305] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.841s)
[88.673549] [014/133] (930s left) kms_cursor_edge_walk (64x64-top-edge)
[88.755660] Starting subtest: 64x64-top-edge
[88.758132] Starting dynamic subtest: pipe-A-eDP-1
[92.234975] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.480s)
[92.244675] Starting dynamic subtest: pipe-D-eDP-1
[95.360236] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[95.362569] Subtest 64x64-top-edge: SUCCESS (6.607s)
[96.149431] [015/133] (923s left) vgem_basic (dmabuf-mmap)
[96.228377] Starting subtest: dmabuf-mmap
[96.233943] Subtest dmabuf-mmap: SUCCESS (0.008s)
[96.284405] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[96.287908] [016/133] (923s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[96.360681] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[96.362922] Starting dynamic subtest: pipe-A
[96.423879] Dynamic subtest pipe-A: SUCCESS (0.064s)
[96.434538] Starting dynamic subtest: pipe-B
[97.565421] Dynamic subtest pipe-B: SUCCESS (1.141s)
[97.576837] Starting dynamic subtest: pipe-C
[98.688825] Dynamic subtest pipe-C: SUCCESS (1.122s)
[98.697649] Starting dynamic subtest: pipe-D
[99.806102] Dynamic subtest pipe-D: SUCCESS (1.116s)
[99.808496] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.447s)
[100.973321] [017/133] (918s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[101.044192] Starting subtest: bad-rotation-90-yf-tiled-ccs
[101.046450] Starting dynamic subtest: pipe-A-eDP-1
[101.069122] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.078633] Starting dynamic subtest: pipe-B-eDP-1
[101.100866] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.108924] Starting dynamic subtest: pipe-C-eDP-1
[101.130756] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.138376] Starting dynamic subtest: pipe-D-eDP-1
[101.160640] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.164745] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[103.342976] [018/133] (916s left) gem_ctx_exec (basic)
[103.392701] Starting subtest: basic
[103.397783] Subtest basic: SUCCESS (0.006s)
[103.521712] [019/133] (916s left) gem_exec_schedule (pi-shared-iova)
[103.691468] Starting subtest: pi-shared-iova
[103.693566] Starting dynamic subtest: rcs0
[103.765243] Dynamic subtest rcs0: SUCCESS (0.078s)
[103.781586] Starting dynamic subtest: vcs0
[103.823330] Dynamic subtest vcs0: SUCCESS (0.056s)
[103.836456] Starting dynamic subtest: vcs1
[103.875668] Dynamic subtest vcs1: SUCCESS (0.053s)
[103.887479] Starting dynamic subtest: vecs0
[103.927556] Dynamic subtest vecs0: SUCCESS (0.051s)
[103.938613] Starting dynamic subtest: ccs0
[103.981918] Dynamic subtest ccs0: SUCCESS (0.054s)
[103.984256] Subtest pi-shared-iova: SUCCESS (0.296s)
[105.308616] [020/133] (914s left) device_reset (unbind-reset-rebind)
[105.359064] Starting subtest: unbind-reset-rebind
[111.469057] Subtest unbind-reset-rebind: SUCCESS (6.105s)
[111.510174] [021/133] (908s left) syncobj_timeline (wait-all-snapshot)
[111.572508] Starting subtest: wait-all-snapshot
[111.653474] Subtest wait-all-snapshot: SUCCESS (0.082s)
[111.729660] [022/133] (907s left) gem_mmap_gtt (medium-copy-xy)
[111.788477] Subtest medium-copy-XY: SKIP (0.000s)
[111.851614] [023/133] (907s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[111.895184] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[111.897150] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[111.989974] [024/133] (907s left) perf_pmu (busy-check-all)
[112.029659] Starting subtest: busy-check-all
[112.032053] Starting dynamic subtest: rcs0
[112.581154] Dynamic subtest rcs0: SUCCESS (0.552s)
[112.595450] Starting dynamic subtest: bcs0
[113.133356] Dynamic subtest bcs0: SUCCESS (0.551s)
[113.145830] Starting dynamic subtest: vcs0
[114.239049] Dynamic subtest vcs0: SUCCESS (1.100s)
[114.249448] Starting dynamic subtest: vcs1
[116.221584] Dynamic subtest vcs1: SUCCESS (1.982s)
[116.232875] Starting dynamic subtest: vecs0
[118.205532] Dynamic subtest vecs0: SUCCESS (1.982s)
[118.217669] Starting dynamic subtest: ccs0
[118.758158] Dynamic subtest ccs0: SUCCESS (0.553s)
[118.760675] Subtest busy-check-all: SUCCESS (6.730s)
[118.864750] [025/133] (900s left) syncobj_timeline (invalid-query-illegal-handle)
[118.922759] Starting subtest: invalid-query-illegal-handle
[118.925171] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[119.031387] [026/133] (900s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[119.136748] Starting subtest: cursorA-vs-flipA-atomic-transitions
[130.337086] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.200s)
[131.160053] [027/133] (888s left) gem_tiled_swapping (non-threaded)
[131.214594] Subtest non-threaded: SKIP (0.000s)
[131.280855] [028/133] (888s left) kms_plane_multiple (tiling-x)
[131.362850] Starting subtest: tiling-x
[131.365107] Starting dynamic subtest: pipe-A-eDP-1
[135.084639] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.720s)
[135.095131] Starting dynamic subtest: pipe-B-eDP-1
[139.565219] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.480s)
[139.575746] Starting dynamic subtest: pipe-C-eDP-1
[143.950893] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.383s)
[143.960613] Starting dynamic subtest: pipe-D-eDP-1
[148.278075] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.326s)
[148.280465] Subtest tiling-x: SUCCESS (16.915s)
[149.081607] [029/133] (870s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[149.167699] Starting subtest: yf-tiled-16bpp-rotate-270
[149.171779] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[149.280579] [030/133] (870s left) kms_psr (pr-cursor-mmap-cpu)
[149.345160] Starting subtest: pr-cursor-mmap-cpu
[149.349613] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[149.417590] [031/133] (870s left) gem_ctx_param (invalid-get-ringsize)
[149.462351] Starting subtest: invalid-get-ringsize
[149.464607] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[149.566256] [032/133] (870s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[149.642637] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[156.249181] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.609s)
[156.379220] [033/133] (863s left) gem_exec_whisper (basic-fds-all)
[156.448674] Starting subtest: basic-fds-all
[167.311308] Subtest basic-fds-all: SUCCESS (10.860s)
[167.496246] [034/133] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[167.579654] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[167.583780] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[167.684326] [035/133] (852s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[167.740162] Starting subtest: invalid-multi-wait-unsubmitted
[167.742433] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[167.849553] [036/133] (852s left) gem_mmap_offset (close-race)
[167.900923] Starting subtest: close-race
[193.807579] Subtest close-race: SUCCESS (25.907s)
[193.941878] [037/133] (826s left) kms_psr (psr-cursor-render)
[194.017162] Starting subtest: psr-cursor-render
[194.019467] Starting dynamic subtest: eDP-1
[195.732571] Dynamic subtest eDP-1: SUCCESS (1.716s)
[195.734729] Subtest psr-cursor-render: SUCCESS (1.717s)
[196.609646] [038/133] (823s left) perf_pmu (interrupts)
[196.651409] Starting subtest: interrupts
[197.742677] Subtest interrupts: SUCCESS (1.090s)
[197.850370] [039/133] (822s left) api_intel_allocator (alloc-simple)
[197.896866] Starting subtest: alloc-simple
[197.899254] Subtest alloc-simple: SUCCESS (0.003s)
[198.026713] [040/133] (822s left) kms_psr (psr-primary-blt)
[198.106698] Starting subtest: psr-primary-blt
[198.109059] Starting dynamic subtest: eDP-1
[199.801658] Dynamic subtest eDP-1: SUCCESS (1.693s)
[199.804044] Subtest psr-primary-blt: SUCCESS (1.694s)
[200.657592] [041/133] (819s left) kms_cursor_crc (cursor-random-512x170)
[200.912132] Starting subtest: cursor-random-512x170
[200.916367] Subtest cursor-random-512x170: SKIP (0.001s)
[201.063744] [042/133] (819s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[201.125271] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[201.233940] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[201.310380] [043/133] (819s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[203.304239] Starting subtest: gem-execbuf-stress-pc8
[203.349283] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[203.680189] [044/133] (816s left) gem_reg_read (bad-register)
[203.734286] Starting subtest: bad-register
[203.736152] Subtest bad-register: SUCCESS (0.000s)
[203.834856] [045/133] (816s left) gem_mmap_gtt (basic-small-copy-odd)
[203.885156] Subtest basic-small-copy-odd: SKIP (0.000s)
[203.942722] [046/133] (816s left) i915_hangman (gt-engine-hang)
[204.008240] Starting subtest: gt-engine-hang
[204.010473] Starting dynamic subtest: rcs0
[205.212602] Dynamic subtest rcs0: SUCCESS (1.204s)
[205.226387] Starting dynamic subtest: bcs0
[207.195444] Dynamic subtest bcs0: SUCCESS (1.980s)
[207.207314] Starting dynamic subtest: vcs0
[209.180759] Dynamic subtest vcs0: SUCCESS (1.983s)
[209.199689] Starting dynamic subtest: vcs1
[211.163877] Dynamic subtest vcs1: SUCCESS (1.980s)
[211.176918] Starting dynamic subtest: vecs0
[213.211886] Dynamic subtest vecs0: SUCCESS (2.045s)
[213.225309] Starting dynamic subtest: ccs0
[215.196542] Dynamic subtest ccs0: SUCCESS (1.982s)
[215.199477] Subtest gt-engine-hang: SUCCESS (11.190s)
[215.324311] [047/133] (805s left) fbdev (pan)
[215.362803] Starting subtest: pan
[215.397095] Subtest pan: SUCCESS (0.036s)
[215.470658] [048/133] (805s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[215.560340] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[216.665467] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.518s)
[216.711310] [049/133] (804s left) prime_self_import (basic-with_one_bo)
[216.744086] Starting subtest: basic-with_one_bo
[216.762501] Subtest basic-with_one_bo: SUCCESS (0.019s)
[216.893116] [050/133] (804s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[216.966977] Starting subtest: 2x-flip-vs-modeset-vs-hang
[216.970351] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.001s)
[217.083501] [051/133] (803s left) kms_flip (2x-flip-vs-suspend)
[217.162131] Starting subtest: 2x-flip-vs-suspend
[217.165885] Subtest 2x-flip-vs-suspend: SKIP (0.001s)
[217.274996] [052/133] (803s left) i915_query (query-garbage)
[217.327877] Starting subtest: query-garbage
[217.329548] Subtest query-garbage: SUCCESS (0.000s)
[217.434475] [053/133] (803s left) kms_pm_dc (dc5-retention-flops)
[218.516413] Starting subtest: dc5-retention-flops
[218.520946] Subtest dc5-retention-flops: SKIP (0.000s)
[218.588904] [054/133] (802s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[218.681076] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[218.685606] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[218.766314] [055/133] (802s left) kms_atomic_interruptible (legacy-dpms)
[218.848418] Starting subtest: legacy-dpms
[218.850775] Starting dynamic subtest: pipe-A-eDP-1
[226.322439] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.473s)
[226.324709] Subtest legacy-dpms: SUCCESS (7.474s)
[227.139567] [056/133] (794s left) gem_basic (create-close)
[227.187280] Starting subtest: create-close
[227.191666] Subtest create-close: SUCCESS (0.000s)
[227.280381] [057/133] (793s left) sysfs_timeslice_duration (idempotent)
[227.328465] Starting subtest: idempotent
[227.330859] Starting dynamic subtest: vecs0
[227.333256] Dynamic subtest vecs0: SUCCESS (0.000s)
[227.344862] Starting dynamic subtest: ccs0
[227.347140] Dynamic subtest ccs0: SUCCESS (0.000s)
[227.356708] Starting dynamic subtest: vcs0
[227.358961] Dynamic subtest vcs0: SUCCESS (0.000s)
[227.368537] Starting dynamic subtest: bcs0
[227.370813] Dynamic subtest bcs0: SUCCESS (0.000s)
[227.380229] Starting dynamic subtest: rcs0
[227.382116] Dynamic subtest rcs0: SUCCESS (0.000s)
[227.392696] Starting dynamic subtest: vcs1
[227.394931] Dynamic subtest vcs1: SUCCESS (0.001s)
[227.397242] Subtest idempotent: SUCCESS (0.006s)
[227.444335] [058/133] (793s left) kms_cursor_crc (cursor-offscreen-128x128)
[227.643104] Starting subtest: cursor-offscreen-128x128
[227.645433] Starting dynamic subtest: pipe-A-eDP-1
[229.592863] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.947s)
[229.623809] Starting dynamic subtest: pipe-D-eDP-1
[232.173086] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.557s)
[232.175431] Subtest cursor-offscreen-128x128: SUCCESS (4.531s)
[233.032721] [059/133] (788s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[233.115608] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[233.119916] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[233.202871] [060/133] (788s left) gem_pxp (regular-baseline-src-copy-readible)
[233.316207] Starting subtest: regular-baseline-src-copy-readible
[233.372960] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[233.494556] [061/133] (787s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[233.577500] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[233.581538] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[233.652223] [062/133] (787s left) gem_exec_schedule (fairslice)
[233.716044] Starting subtest: fairslice
[233.717904] Starting dynamic subtest: rcs0
[235.727717] Dynamic subtest rcs0: SUCCESS (2.020s)
[235.738197] Starting dynamic subtest: bcs0
[237.749881] Dynamic subtest bcs0: SUCCESS (2.020s)
[237.759903] Starting dynamic subtest: vcs0
[239.771423] Dynamic subtest vcs0: SUCCESS (2.019s)
[239.784366] Starting dynamic subtest: vcs1
[241.790439] Dynamic subtest vcs1: SUCCESS (2.016s)
[241.800598] Starting dynamic subtest: vecs0
[243.805594] Dynamic subtest vecs0: SUCCESS (2.016s)
[243.815430] Starting dynamic subtest: ccs0
[245.826371] Dynamic subtest ccs0: SUCCESS (2.018s)
[245.828682] Subtest fairslice: SUCCESS (12.116s)
[246.124511] [063/133] (775s left) kms_frontbuffer_tracking (psr-2p-rte)
[246.199419] Starting subtest: psr-2p-rte
[246.203788] Subtest psr-2p-rte: SKIP (0.000s)
[246.299539] [064/133] (775s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[246.377527] Starting subtest: plane-lut1d-pre-ctm3x4
[246.523490] Starting dynamic subtest: pipe-A-plane-0
[246.712372] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[246.723507] Starting dynamic subtest: pipe-A-plane-1
[246.890070] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[246.900340] Starting dynamic subtest: pipe-A-plane-2
[247.045784] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[248.226100] Starting dynamic subtest: pipe-B-plane-0
[248.406817] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[248.417071] Starting dynamic subtest: pipe-B-plane-1
[248.562507] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[248.574505] Starting dynamic subtest: pipe-B-plane-2
[248.718183] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[249.934670] Starting dynamic subtest: pipe-C-plane-0
[250.080591] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[250.091751] Starting dynamic subtest: pipe-C-plane-1
[250.214039] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[250.225717] Starting dynamic subtest: pipe-C-plane-2
[250.369474] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[251.566645] Starting dynamic subtest: pipe-D-plane-0
[251.691526] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[251.701696] Starting dynamic subtest: pipe-D-plane-1
[251.847136] Dynamic subtest pipe-D-plane-1: SUCCESS (0.154s)
[251.858066] Starting dynamic subtest: pipe-D-plane-2
[251.980737] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[252.267884] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.889s)
[253.133164] [065/133] (768s left) gem_exec_balancer (semaphore)
[253.200038] Starting subtest: semaphore
[255.205235] Subtest semaphore: SUCCESS (2.006s)
[255.532862] [066/133] (766s left) kms_content_protection (dp-mst-type-0)
[255.666174] Starting subtest: dp-mst-type-0
[255.670434] Subtest dp-mst-type-0: SKIP (0.000s)
[255.801412] [067/133] (765s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[255.886629] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[255.890967] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[255.982801] [068/133] (765s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[256.093563] Starting subtest: 2x-flip-vs-cursor-atomic
[256.097971] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[256.235953] [069/133] (765s left) kms_lease (lease-invalid-crtc)
[256.305705] Starting subtest: lease-invalid-crtc
[256.307976] Starting dynamic subtest: pipe-A-eDP-1
[256.310154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[256.319879] Starting dynamic subtest: pipe-B-eDP-1
[256.322005] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[256.331593] Starting dynamic subtest: pipe-C-eDP-1
[256.333792] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[256.343481] Starting dynamic subtest: pipe-D-eDP-1
[256.345764] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[256.348061] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[256.386348] [070/133] (765s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[256.487258] Starting subtest: cursor-vs-flip-atomic-transitions
[286.723883] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.234s)
[287.578857] [071/133] (734s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[287.627801] Starting subtest: yf-tiled-to-vebox-y-tiled
[287.632280] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[287.823514] [072/133] (733s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[287.905944] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[287.908276] Starting dynamic subtest: pipe-A-default-mode
[289.033424] Dynamic subtest pipe-A-default-mode: SKIP (1.125s)
[289.037640] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.126s)
[289.165076] [073/133] (732s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[289.215617] Starting subtest: etime-single-wait-available-unsubmitted
[289.321606] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.106s)
[289.401115] [074/133] (732s left) kms_chamelium_color (ctm-0-50)
[289.466125] Subtest ctm-0-50: SKIP (0.000s)
[289.511708] [075/133] (732s left) kms_invalid_mode (overflow-vrefresh)
[289.589533] Starting subtest: overflow-vrefresh
[289.591823] Starting dynamic subtest: pipe-A-eDP-1
[289.874489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[289.884826] Starting dynamic subtest: pipe-B-eDP-1
[289.886867] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[289.896791] Starting dynamic subtest: pipe-C-eDP-1
[289.899344] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[289.909027] Starting dynamic subtest: pipe-D-eDP-1
[289.911426] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[289.913690] Subtest overflow-vrefresh: SUCCESS (0.297s)
[290.734857] [076/133] (731s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[290.817979] Starting subtest: psr-1p-primscrn-spr-indfb-move
[298.265526] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.450s)
[298.367306] [077/133] (723s left) gem_create (hog-create)
[298.423625] Starting subtest: hog-create
[298.425894] Starting dynamic subtest: smem0
[332.197284] Dynamic subtest smem0: SUCCESS (33.771s)
[332.199849] Subtest hog-create: SUCCESS (33.773s)
[332.383554] [078/133] (689s left) gem_unref_active_buffers
[332.572398] [079/133] (689s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[332.650188] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[332.654626] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[332.753679] [080/133] (689s left) kms_big_fb (y-tiled-addfb-size-overflow)
[332.834352] Starting subtest: y-tiled-addfb-size-overflow
[332.838474] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[332.942837] [081/133] (689s left) gem_exec_reloc (basic-write-cpu-active)
[333.007353] Subtest basic-write-cpu-active: SKIP (0.000s)
[333.076655] [082/133] (689s left) kms_pm_rpm (legacy-planes-dpms)
[334.580039] Starting subtest: legacy-planes-dpms
[334.582847] Starting dynamic subtest: plane-65
[342.885033] Dynamic subtest plane-65: SUCCESS (8.303s)
[342.903509] Starting dynamic subtest: plane-95
[351.171847] Dynamic subtest plane-95: SUCCESS (8.284s)
[351.184064] Starting dynamic subtest: plane-125
[359.472879] Dynamic subtest plane-125: SUCCESS (8.299s)
[359.486536] Starting dynamic subtest: plane-135
[367.785333] Dynamic subtest plane-135: SUCCESS (8.309s)
[367.788191] Subtest legacy-planes-dpms: SUCCESS (33.206s)
[368.153964] [083/133] (654s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[368.230125] Starting subtest: disable-crc-after-crtc
[368.232539] Starting dynamic subtest: pipe-A-eDP-1
[369.888972] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.657s)
[369.900651] Starting dynamic subtest: pipe-B-eDP-1
[372.165308] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.276s)
[372.176386] Starting dynamic subtest: pipe-C-eDP-1
[374.425659] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.258s)
[374.438816] Starting dynamic subtest: pipe-D-eDP-1
[376.702515] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.274s)
[376.704858] Subtest disable-crc-after-crtc: SUCCESS (8.472s)
[377.524964] [084/133] (644s left) prime_udl
[377.606636] [085/133] (644s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[377.692033] Starting subtest: fbcpsr-modesetfrombusy
[383.898851] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.212s)
[384.028433] [086/133] (638s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[384.114546] Starting subtest: x-tiled-8bpp-rotate-270
[384.135429] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[384.260162] [087/133] (638s left) gem_exec_fence (syncobj-repeat)
[384.707070] Starting subtest: syncobj-repeat
[384.887990] Subtest syncobj-repeat: SUCCESS (0.183s)
[386.290611] [088/133] (636s left) gem_softpin (zero)
[386.337539] Starting subtest: zero
[386.342314] Subtest zero: SUCCESS (0.004s)
[386.486350] [089/133] (636s left) gem_ctx_persistence (heartbeat-hostile)
[386.546709] Starting subtest: heartbeat-hostile
[386.551489] Subtest heartbeat-hostile: SKIP (0.000s)
[386.657581] [090/133] (635s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[386.736625] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[386.740662] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[386.850542] [091/133] (635s left) kms_chamelium_frames (hdmi-crc-multiple)
[387.228157] Subtest hdmi-crc-multiple: SKIP (0.000s)
[388.006692] [092/133] (634s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[388.078807] Starting subtest: async-flip-with-page-flip-events-linear
[388.452054] Starting dynamic subtest: pipe-A-eDP-1
[391.192496] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.739s)
[391.566629] Starting dynamic subtest: pipe-B-eDP-1
[394.319370] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s)
[394.684442] Starting dynamic subtest: pipe-C-eDP-1
[397.443200] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[397.813799] Starting dynamic subtest: pipe-D-eDP-1
[400.575687] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[400.578457] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.496s)
[401.769788] [093/133] (620s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[401.840269] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[401.844518] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[401.909939] [094/133] (620s left) gem_exec_params (secure-non-master)
[401.957764] Starting subtest: secure-non-master
[401.962232] Subtest secure-non-master: SKIP (0.000s)
[402.055214] [095/133] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[402.126337] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[402.130717] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[402.217685] [096/133] (620s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[402.289785] Starting subtest: fbc-rgb101010-draw-render
[406.879488] Subtest fbc-rgb101010-draw-render: SUCCESS (4.592s)
[408.072887] [097/133] (614s left) api_intel_bb (reset-flags)
[408.135212] Starting subtest: reset-flags
[408.140816] Subtest reset-flags: SUCCESS (0.007s)
[408.268086] [098/133] (614s left) syncobj_wait (single-wait-submitted)
[408.315465] Starting subtest: single-wait-submitted
[408.416502] Subtest single-wait-submitted: SUCCESS (0.102s)
[408.503263] [099/133] (614s left) i915_query (engine-info)
[408.554101] Starting subtest: engine-info
[408.558636] Subtest engine-info: SUCCESS (0.006s)
[408.691122] [100/133] (614s left) perf_pmu (all-busy-check-all)
[408.724658] Starting subtest: all-busy-check-all
[410.238093] Subtest all-busy-check-all: SUCCESS (1.513s)
[410.359476] [101/133] (612s left) syncobj_basic (bad-flags-fd-to-handle)
[410.409908] Starting subtest: bad-flags-fd-to-handle
[410.412079] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[410.503392] [102/133] (612s left) gem_exec_schedule (u-submit-golden-slice)
[410.573058] Starting subtest: u-submit-golden-slice
[410.575508] Starting dynamic subtest: rcs0
[410.622297] Dynamic subtest rcs0: SUCCESS (0.055s)
[410.633515] Starting dynamic subtest: bcs0
[410.661552] Dynamic subtest bcs0: SUCCESS (0.039s)
[410.672960] Starting dynamic subtest: vcs0
[410.707663] Dynamic subtest vcs0: SUCCESS (0.045s)
[410.719016] Starting dynamic subtest: vcs1
[410.751988] Dynamic subtest vcs1: SUCCESS (0.044s)
[410.764634] Starting dynamic subtest: vecs0
[410.795922] Dynamic subtest vecs0: SUCCESS (0.042s)
[410.808283] Starting dynamic subtest: ccs0
[410.836302] Dynamic subtest ccs0: SUCCESS (0.040s)
[410.838662] Subtest u-submit-golden-slice: SUCCESS (0.270s)
[412.334441] [103/133] (610s left) i915_drm_fdinfo (memory-info-shared)
[412.374133] Starting subtest: memory-info-shared
[412.376409] Starting dynamic subtest: smem0
[412.419819] Dynamic subtest smem0: SUCCESS (0.049s)
[412.422818] Subtest memory-info-shared: SUCCESS (0.050s)
[412.494698] [104/133] (610s left) gem_mmap_wc (write-read-distinct)
[412.553550] Subtest write-read-distinct: SKIP (0.000s)
[412.614829] [105/133] (610s left) kms_selftest (drm_damage_helper)
[412.649401] Starting subtest: drm_damage_helper
[412.660135] Starting dynamic subtest: drm_test_damage_iter_no_damage
[412.768629] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.106s)
[412.780311] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[412.872165] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.103s)
[412.886100] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[412.970605] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.099s)
[412.980618] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[413.060045] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.086s)
[413.071023] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[413.160322] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.099s)
[413.170194] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[413.249258] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.087s)
[413.261353] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[413.336291] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.087s)
[413.346154] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[413.429067] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.091s)
[413.440653] Starting dynamic subtest: drm_test_damage_iter_single_damage
[413.528326] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.099s)
[413.538467] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[413.648395] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.117s)
[413.660970] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[413.744239] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.097s)
[413.755878] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[413.837920] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.092s)
[413.847912] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[413.948413] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.107s)
[413.959892] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[414.035980] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.087s)
[414.047218] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[414.136248] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.100s)
[414.145800] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[414.238548] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.100s)
[414.248027] Starting dynamic subtest: drm_test_damage_iter_damage
[414.330212] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.092s)
[414.340014] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[414.418056] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.087s)
[414.427924] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[414.509069] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.090s)
[414.519654] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[414.602479] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.092s)
[414.612229] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[414.699473] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.096s)
[414.701127] Subtest drm_damage_helper: SUCCESS (2.052s)
[414.854163] [106/133] (608s left) prime_mmap (test_correct_cpu_write)
[414.901768] Starting subtest: test_correct_cpu_write
[414.903649] Starting dynamic subtest: test_correct_cpu_write-smem
[414.905436] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.001s)
[414.907159] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[414.994103] [107/133] (608s left) gen9_exec_parse (secure-batches)
[415.046525] Subtest secure-batches: SKIP (0.000s)
[415.119866] [108/133] (608s left) kms_atomic (plane-immutable-zpos)
[415.196137] Starting subtest: plane-immutable-zpos
[415.198118] Starting dynamic subtest: pipe-A-eDP-1
[415.833484] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.637s)
[415.835913] Subtest plane-immutable-zpos: SUCCESS (0.638s)
[416.699105] [109/133] (606s left) gem_exec_nop (basic-parallel)
[416.769890] Starting subtest: basic-parallel
[432.254595] Subtest basic-parallel: SUCCESS (15.494s)
[432.476452] [110/133] (590s left) kms_psr (fbc-psr-sprite-render)
[432.561799] Starting subtest: fbc-psr-sprite-render
[432.563991] Starting dynamic subtest: eDP-1
[432.567942] Dynamic subtest eDP-1: SKIP (0.000s)
[432.571910] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[432.635464] [111/133] (590s left) gem_fenced_exec_thrash (2-spare-fences)
[432.688926] Subtest 2-spare-fences: SKIP (0.000s)
[432.753658] [112/133] (590s left) perf_pmu (idle)
[432.788610] Starting subtest: idle
[432.790944] Starting dynamic subtest: rcs0
[433.341690] Dynamic subtest rcs0: SUCCESS (0.547s)
[433.355179] Starting dynamic subtest: bcs0
[433.854357] Dynamic subtest bcs0: SUCCESS (0.514s)
[433.866062] Starting dynamic subtest: vcs0
[434.370315] Dynamic subtest vcs0: SUCCESS (0.513s)
[434.383852] Starting dynamic subtest: vcs1
[434.893341] Dynamic subtest vcs1: SUCCESS (0.520s)
[434.908082] Starting dynamic subtest: vecs0
[435.412408] Dynamic subtest vecs0: SUCCESS (0.516s)
[435.426303] Starting dynamic subtest: ccs0
[435.933838] Dynamic subtest ccs0: SUCCESS (0.518s)
[435.937252] Subtest idle: SUCCESS (3.146s)
[436.060078] [113/133] (587s left) kms_vblank (wait-busy-hang)
[436.139748] Starting subtest: wait-busy-hang
[436.142038] Starting dynamic subtest: pipe-A-eDP-1
[463.047099] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.907s)
[463.061933] Starting dynamic subtest: pipe-D-eDP-1
[478.015724] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.965s)
[478.018039] Subtest wait-busy-hang: SUCCESS (41.876s)
[478.851858] [114/133] (544s left) gem_exec_balancer (noheartbeat)
[479.125756] Starting subtest: noheartbeat
[479.130078] Subtest noheartbeat: SKIP (0.000s)
[479.222293] [115/133] (544s left) kms_hdr (brightness-with-hdr)
[479.296434] Starting subtest: brightness-with-hdr
[479.302937] Subtest brightness-with-hdr: SKIP (0.000s)
[479.368455] [116/133] (544s left) kms_flip (blocking-wf_vblank)
[479.440273] Starting subtest: blocking-wf_vblank
[479.442206] Starting dynamic subtest: A-eDP1
[488.388417] Dynamic subtest A-eDP1: SUCCESS (8.949s)
[488.402203] Starting dynamic subtest: B-eDP1
[497.323209] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[497.335766] Starting dynamic subtest: C-eDP1
[506.244210] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[506.256691] Starting dynamic subtest: D-eDP1
[515.167892] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[515.170226] Subtest blocking-wf_vblank: SUCCESS (35.730s)
[516.405106] [117/133] (507s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[516.478304] Starting subtest: pixel-format-linear-modifier-source-clamping
[516.504783] Starting dynamic subtest: pipe-A-plane-0
[517.082087] Dynamic subtest pipe-A-plane-0: SUCCESS (0.577s)
[517.092763] Starting dynamic subtest: pipe-A-plane-3
[517.526169] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s)
[518.664040] Starting dynamic subtest: pipe-B-plane-0
[519.235368] Dynamic subtest pipe-B-plane-0: SUCCESS (0.577s)
[519.245596] Starting dynamic subtest: pipe-B-plane-3
[519.677344] Dynamic subtest pipe-B-plane-3: SUCCESS (0.443s)
[519.992131] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.513s)
[520.832946] [118/133] (502s left) gem_lmem_swapping (heavy-verify-multi)
[520.877661] Subtest heavy-verify-multi: SKIP (0.000s)
[520.918826] [119/133] (502s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[521.001360] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[525.478843] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.482s)
[526.641282] [120/133] (497s left) kms_big_fb (4-tiled-addfb-size-overflow)
[526.717866] Starting subtest: 4-tiled-addfb-size-overflow
[526.720266] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[526.813950] [121/133] (497s left) gem_vm_create (invalid-create)
[526.862783] Starting subtest: invalid-create
[526.865083] Subtest invalid-create: SUCCESS (0.002s)
[526.972968] [122/133] (496s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[527.047914] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[527.050145] Starting dynamic subtest: pipe-A-eDP-1
[527.074386] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[527.085387] Starting dynamic subtest: pipe-B-eDP-1
[527.108624] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[527.119638] Starting dynamic subtest: pipe-C-eDP-1
[527.144185] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[527.155974] Starting dynamic subtest: pipe-D-eDP-1
[527.180542] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[527.184698] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[529.302931] [123/133] (494s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[529.378173] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[536.388535] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.015s)
[536.499723] [124/133] (487s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[536.574768] Starting subtest: fbc-psr2-cursor-mmap-cpu
[536.577096] Starting dynamic subtest: eDP-1
[536.581432] Dynamic subtest eDP-1: SKIP (0.000s)
[536.585700] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[536.650947] [125/133] (487s left) syncobj_basic (bad-create-flags)
[536.714654] Starting subtest: bad-create-flags
[536.716976] Subtest bad-create-flags: SUCCESS (0.000s)
[536.823775] [126/133] (487s left) perf (enable-disable)
[536.942328] Starting subtest: enable-disable
[536.944625] Starting dynamic subtest: 0-rcs0
[539.190496] Dynamic subtest 0-rcs0: SUCCESS (2.249s)
[539.202108] Starting dynamic subtest: 1-vecs0
[543.641325] Dynamic subtest 1-vecs0: SUCCESS (4.448s)
[543.643730] Subtest enable-disable: SUCCESS (6.699s)
[543.693317] [127/133] (480s left) gem_ctx_shared (q-smoketest)
[543.764063] Starting subtest: Q-smoketest
[543.766463] Starting dynamic subtest: rcs0
[549.336576] Dynamic subtest rcs0: SUCCESS (5.521s)
[549.349586] Starting dynamic subtest: bcs0
[554.824653] Dynamic subtest bcs0: SUCCESS (5.488s)
[554.836374] Starting dynamic subtest: vcs0
[560.306258] Dynamic subtest vcs0: SUCCESS (5.477s)
[560.319948] Starting dynamic subtest: vcs1
[565.780709] Dynamic subtest vcs1: SUCCESS (5.474s)
[565.793569] Starting dynamic subtest: vecs0
[571.266966] Dynamic subtest vecs0: SUCCESS (5.488s)
[571.278067] Starting dynamic subtest: ccs0
[576.756914] Dynamic subtest ccs0: SUCCESS (5.486s)
[576.759218] Subtest Q-smoketest: SUCCESS (32.940s)
[576.897908] [128/133] (447s left) gem_exec_flush (basic-wb-rw-before-default)
[576.967741] Starting subtest: basic-wb-rw-before-default
[582.433193] Subtest basic-wb-rw-before-default: SUCCESS (5.466s)
[582.619642] [129/133] (441s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[582.704875] Starting subtest: psr-rgb565-draw-mmap-wc
[589.507716] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.805s)
[589.633782] [130/133] (434s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[589.706160] Starting subtest: crc-primary-basic-yf-tiled-ccs
[589.708439] Starting dynamic subtest: pipe-A-eDP-1
[589.731378] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[589.744379] Starting dynamic subtest: pipe-B-eDP-1
[589.766028] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[589.776193] Starting dynamic subtest: pipe-C-eDP-1
[589.798299] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[589.807896] Starting dynamic subtest: pipe-D-eDP-1
[589.829702] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[589.834173] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[591.999440] [131/133] (432s left) kms_cursor_legacy (forked-move)
[592.098627] Starting subtest: forked-move
[592.100916] Starting dynamic subtest: pipe-A
[597.566913] Dynamic subtest pipe-A: SUCCESS (5.465s)
[597.582401] Starting dynamic subtest: pipe-B
[603.046626] Dynamic subtest pipe-B: SUCCESS (5.477s)
[603.073092] Starting dynamic subtest: pipe-C
[608.524943] Dynamic subtest pipe-C: SUCCESS (5.475s)
[608.547194] Starting dynamic subtest: pipe-D
[614.001197] Dynamic subtest pipe-D: SUCCESS (5.471s)
[614.015276] Starting dynamic subtest: all-pipes
[619.513651] Dynamic subtest all-pipes: SUCCESS (5.511s)
[619.516445] Subtest forked-move: SUCCESS (27.411s)
[619.659210] [132/133] (404s left) prime_vgem (fence-wait)
[619.731643] Starting subtest: fence-wait
[619.733971] Starting dynamic subtest: rcs0
[620.791537] Dynamic subtest rcs0: SUCCESS (1.058s)
[620.802537] Starting dynamic subtest: bcs0
[621.847383] Dynamic subtest bcs0: SUCCESS (1.054s)
[621.860434] Starting dynamic subtest: vcs0
[622.891680] Dynamic subtest vcs0: SUCCESS (1.043s)
[622.906350] Starting dynamic subtest: vcs1
[623.933193] Dynamic subtest vcs1: SUCCESS (1.040s)
[623.944505] Starting dynamic subtest: vecs0
[624.973359] Dynamic subtest vecs0: SUCCESS (1.038s)
[624.984568] Starting dynamic subtest: ccs0
[626.012903] Dynamic subtest ccs0: SUCCESS (1.037s)
[626.015470] Subtest fence-wait: SUCCESS (6.281s)
[626.132777] [133/133] (398s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[626.208198] Starting subtest: 2x-absolute-wf_vblank-interruptible
[626.218743] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.008s)
[626.288980] 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.