[60.241934] Initializing watchdogs
[60.241981]   /dev/watchdog0
[60.255740] [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]
[60.259869] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.262721] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.265826] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[60.343056] Starting subtest: invalid-bad-pad
[60.345442] Subtest invalid-bad-pad: SUCCESS (0.000s)
[60.485822] [002/131] (960s left) tools_test (tools_test)
[60.531875] Starting subtest: tools_test
[60.584874] Subtest tools_test: SUCCESS (0.066s)
[60.666497] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[60.731256] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[60.797271] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[60.877503] Starting subtest: sync-unmap-cycles
[66.250821] Subtest sync-unmap-cycles: SUCCESS (5.375s)
[66.422811] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[66.535127] Starting subtest: stress-xrgb8888-ytiled
[66.538914] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[66.622460] [006/131] (954s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[66.722885] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[66.724946] Starting dynamic subtest: pipe-A-eDP-1
[82.722260] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.697s)
[82.729731] Starting dynamic subtest: pipe-B-eDP-1
[99.699074] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.370s)
[99.709523] Starting dynamic subtest: pipe-C-eDP-1
[116.684599] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.437s)
[116.698550] Starting dynamic subtest: pipe-D-eDP-1
[133.692792] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.367s)
[133.694783] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (12.874s)
[134.932880] [007/131] (886s left) api_intel_allocator (gem-pool)
[134.999234] Starting subtest: gem-pool
[135.006425] Subtest gem-pool: SUCCESS (0.009s)
[135.165816] [008/131] (885s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[135.279730] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[141.825177] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.550s)
[141.981650] [009/131] (879s left) kms_atomic_interruptible (universal-setplane-primary)
[142.082209] Starting subtest: universal-setplane-primary
[142.084598] Starting dynamic subtest: pipe-A-eDP-1
[149.483164] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.400s)
[149.485536] Subtest universal-setplane-primary: SUCCESS (7.401s)
[150.321972] [010/131] (870s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[150.421772] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[154.678160] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.260s)
[155.913208] [011/131] (865s left) gem_eio (in-flight-contexts-1us)
[156.119445] Starting subtest: in-flight-contexts-1us
[168.048306] Subtest in-flight-contexts-1us: SUCCESS (11.928s)
[168.241702] [012/131] (852s left) gem_exec_balancer (semaphore)
[168.305520] Starting subtest: semaphore
[170.017804] Subtest semaphore: SUCCESS (1.710s)
[170.367935] [013/131] (850s left) kms_chamelium_hpd (hdmi-hpd)
[170.751771] Subtest hdmi-hpd: SKIP (0.000s)
[171.589281] [014/131] (849s left) kms_flip (wf_vblank-ts-check)
[171.690706] Starting subtest: wf_vblank-ts-check
[171.692770] Starting dynamic subtest: A-eDP1
[180.657958] Dynamic subtest A-eDP1: SUCCESS (8.969s)
[180.668984] Starting dynamic subtest: B-eDP1
[189.582715] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[189.593071] Starting dynamic subtest: C-eDP1
[198.503021] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[198.513231] Starting dynamic subtest: D-eDP1
[207.429143] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[207.431643] Subtest wf_vblank-ts-check: SUCCESS (35.743s)
[208.679237] [015/131] (812s left) gem_exec_reloc (basic-gtt)
[208.765528] Subtest basic-gtt: SKIP (0.000s)
[208.850186] [016/131] (812s left) gem_exec_schedule (reorder-wide)
[209.032166] Subtest reorder-wide: SKIP (0.000s)
[209.231024] [017/131] (812s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[209.328346] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[209.330529] Starting dynamic subtest: pipe-A-eDP-1
[209.352648] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[209.363285] Starting dynamic subtest: pipe-B-eDP-1
[209.384673] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[209.393029] Starting dynamic subtest: pipe-C-eDP-1
[209.414113] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[209.422455] Starting dynamic subtest: pipe-D-eDP-1
[209.445245] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[209.449800] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[211.635294] [018/131] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[211.733745] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[211.738155] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[211.854900] [019/131] (809s left) perf (polling)
[211.999582] Starting subtest: polling
[212.001777] Starting dynamic subtest: 0-rcs0
[222.031679] Dynamic subtest 0-rcs0: SUCCESS (10.032s)
[222.040277] Starting dynamic subtest: 1-vcs0
[232.053868] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[232.056386] Subtest polling: SUCCESS (20.054s)
[232.100803] [020/131] (789s left) gem_userptr_blits (probe)
[232.172993] Starting subtest: probe
[232.244927] Subtest probe: SUCCESS (0.072s)
[232.392664] [021/131] (789s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[232.485957] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[232.490213] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[232.614402] [022/131] (788s left) gem_mmap_offset (pf-nonblock)
[232.661257] Starting subtest: pf-nonblock
[232.666045] Subtest pf-nonblock: SUCCESS (0.006s)
[232.804655] [023/131] (788s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[232.888114] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[232.890424] Starting dynamic subtest: pipe-A-eDP-1
[232.914477] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[232.923344] Starting dynamic subtest: pipe-B-eDP-1
[232.946262] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.954674] Starting dynamic subtest: pipe-C-eDP-1
[232.977795] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.986216] Starting dynamic subtest: pipe-D-eDP-1
[233.010415] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[233.014495] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[235.121213] [024/131] (786s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[235.219323] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[235.223657] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[235.357955] [025/131] (786s left) core_getstats (basic)
[235.414180] Starting subtest: basic
[235.416353] Subtest basic: SUCCESS (0.000s)
[235.531148] [026/131] (786s left) core_getclient (basic)
[235.598129] Starting subtest: basic
[235.600499] Subtest basic: SUCCESS (0.000s)
[235.732410] [027/131] (785s left) syncobj_timeline (multi-wait-all-available-submitted)
[235.788919] Starting subtest: multi-wait-all-available-submitted
[235.791146] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[235.921123] [028/131] (785s left) gem_exec_reloc (basic-write-wc)
[235.988579] Subtest basic-write-wc: SKIP (0.000s)
[236.069456] [029/131] (785s left) kms_invalid_mode (clock-too-high)
[236.164878] Starting subtest: clock-too-high
[236.166793] Starting dynamic subtest: pipe-A-eDP-1
[236.170409] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[236.179395] Starting dynamic subtest: pipe-B-eDP-1
[236.182863] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[236.190721] Starting dynamic subtest: pipe-C-eDP-1
[236.194120] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[236.201445] Starting dynamic subtest: pipe-D-eDP-1
[236.204814] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[236.208174] Subtest clock-too-high: SKIP (0.004s)
[236.264375] [030/131] (785s left) gem_mmap_offset (bad-object)
[236.328112] Starting subtest: bad-object
[236.329969] Subtest bad-object: SUCCESS (0.001s)
[236.462723] [031/131] (785s left) syncobj_timeline (wait-all-delayed-signal)
[236.527185] Starting subtest: wait-all-delayed-signal
[236.631166] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[236.730863] [032/131] (785s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[236.829493] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[237.486628] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s)
[237.710305] [033/131] (784s left) gem_exec_suspend (basic-s3)
[237.783190] Starting subtest: basic-S3
[237.785540] Starting dynamic subtest: smem
[257.492209] Dynamic subtest smem: SUCCESS (6.220s)
[257.494984] Subtest basic-S3: SUCCESS (6.222s)
[257.703373] [034/131] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[257.821067] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[257.826073] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[257.934791] [035/131] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[258.045279] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[258.051067] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[258.194616] [036/131] (763s left) kms_chamelium_frames (hdmi-crc-multiple)
[258.576990] Subtest hdmi-crc-multiple: SKIP (0.000s)
[259.390820] [037/131] (762s left) gem_exec_fence (syncobj-import)
[259.903759] Starting subtest: syncobj-import
[259.909316] Subtest syncobj-import: SUCCESS (0.006s)
[261.582963] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[261.586535] [038/131] (760s left) kms_legacy_colorkey (basic)
[261.687074] Starting subtest: basic
[261.689782] Starting dynamic subtest: pipe-A
[261.730203] Dynamic subtest pipe-A: SUCCESS (0.045s)
[261.742217] Starting dynamic subtest: pipe-B
[261.744627] Dynamic subtest pipe-B: SUCCESS (0.001s)
[261.753219] Starting dynamic subtest: pipe-C
[261.756026] Dynamic subtest pipe-C: SUCCESS (0.000s)
[261.764807] Starting dynamic subtest: pipe-D
[261.766933] Dynamic subtest pipe-D: SUCCESS (0.000s)
[261.769126] Subtest basic: SUCCESS (0.050s)
[261.822544] [039/131] (760s left) gem_softpin (allocator-nopin-reserve)
[261.892107] Starting subtest: allocator-nopin-reserve
[261.977594] Subtest allocator-nopin-reserve: SUCCESS (0.085s)
[262.147163] [040/131] (760s left) perf_pmu (enable-race)
[262.184822] Starting subtest: enable-race
[262.187826] Starting dynamic subtest: rcs0
[274.950434] Dynamic subtest rcs0: SUCCESS (12.764s)
[274.962644] Starting dynamic subtest: bcs0
[287.693220] Dynamic subtest bcs0: SUCCESS (12.741s)
[287.703351] Starting dynamic subtest: vcs0
[303.442567] Dynamic subtest vcs0: SUCCESS (15.745s)
[303.454467] Starting dynamic subtest: vcs1
[319.441914] Dynamic subtest vcs1: SUCCESS (15.996s)
[319.452293] Starting dynamic subtest: vecs0
[335.441757] Dynamic subtest vecs0: SUCCESS (15.997s)
[335.452115] Starting dynamic subtest: ccs0
[348.188868] Dynamic subtest ccs0: SUCCESS (12.746s)
[348.191562] Subtest enable-race: SUCCESS (86.000s)
[348.305999] [041/131] (674s left) syncobj_timeline (signal-point-0)
[348.373571] Starting subtest: signal-point-0
[348.376522] Subtest signal-point-0: SUCCESS (0.000s)
[348.519418] [042/131] (673s left) gem_tiled_wb
[348.631824] [043/131] (673s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[348.729329] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[348.731499] Starting dynamic subtest: pipe-A-eDP-1
[348.755129] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[348.764061] Starting dynamic subtest: pipe-B-eDP-1
[348.791223] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[348.799525] Starting dynamic subtest: pipe-C-eDP-1
[348.826990] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[348.835550] Starting dynamic subtest: pipe-D-eDP-1
[348.865923] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[348.871159] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[350.990070] [044/131] (671s left) gem_ctx_param (set-priority-invalid-size)
[351.057498] Starting subtest: set-priority-invalid-size
[351.060478] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[351.156827] [045/131] (671s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[351.254068] Starting subtest: plane-ctm3x4-lut1d
[351.269574] Starting dynamic subtest: pipe-A-eDP-1
[352.040980] Dynamic subtest pipe-A-eDP-1: FAIL (0.324s)
[352.645516] Starting dynamic subtest: pipe-B-eDP-1
[353.628495] Dynamic subtest pipe-B-eDP-1: FAIL (0.358s)
[354.079178] Starting dynamic subtest: pipe-C-eDP-1
[355.023705] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[355.402744] Starting dynamic subtest: pipe-D-eDP-1
[356.365337] Dynamic subtest pipe-D-eDP-1: FAIL (0.268s)
[356.367811] Subtest plane-ctm3x4-lut1d: FAIL (4.697s)
[356.805037] [046/131] (665s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[356.942150] Starting subtest: 2x-long-cursor-vs-flip-atomic
[356.946809] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[357.109997] [047/131] (665s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[357.210197] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[357.215117] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[357.341697] [048/131] (665s left) kms_feature_discovery (display-1x)
[357.437643] Starting subtest: display-1x
[357.440019] Subtest display-1x: SUCCESS (0.000s)
[357.532501] [049/131] (665s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[357.632373] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[357.637985] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[357.765652] [050/131] (664s left) i915_drm_fdinfo (most-busy-idle-check-all)
[357.808561] Starting subtest: most-busy-idle-check-all
[357.810549] Starting dynamic subtest: rcs0
[357.814608] Dynamic subtest rcs0: SKIP (0.003s)
[357.824193] Starting dynamic subtest: bcs0
[357.828079] Dynamic subtest bcs0: SKIP (0.000s)
[357.836868] Starting dynamic subtest: vcs0
[357.841037] Dynamic subtest vcs0: SKIP (0.000s)
[357.849649] Starting dynamic subtest: vcs1
[357.854301] Dynamic subtest vcs1: SKIP (0.000s)
[357.864772] Starting dynamic subtest: vecs0
[357.868885] Dynamic subtest vecs0: SKIP (0.000s)
[357.877620] Starting dynamic subtest: ccs0
[357.881300] Dynamic subtest ccs0: SKIP (0.000s)
[357.885204] Subtest most-busy-idle-check-all: SKIP (0.008s)
[357.921146] [051/131] (664s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[358.057891] Starting subtest: x-tiled-32bpp-rotate-270
[358.078378] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[358.237353] [052/131] (664s left) gem_exec_schedule (u-submit-early-slice)
[358.312880] Starting subtest: u-submit-early-slice
[358.314898] Starting dynamic subtest: rcs0
[358.353685] Dynamic subtest rcs0: SUCCESS (0.048s)
[358.363524] Starting dynamic subtest: bcs0
[358.388568] Dynamic subtest bcs0: SUCCESS (0.034s)
[358.396742] Starting dynamic subtest: vcs0
[358.425468] Dynamic subtest vcs0: SUCCESS (0.036s)
[358.433611] Starting dynamic subtest: vcs1
[358.459355] Dynamic subtest vcs1: SUCCESS (0.033s)
[358.467722] Starting dynamic subtest: vecs0
[358.495355] Dynamic subtest vecs0: SUCCESS (0.035s)
[358.503443] Starting dynamic subtest: ccs0
[358.529665] Dynamic subtest ccs0: SUCCESS (0.033s)
[358.531754] Subtest u-submit-early-slice: SUCCESS (0.225s)
[359.638885] [053/131] (663s left) gem_pxp (regular-baseline-src-copy-readible)
[359.763252] Starting subtest: regular-baseline-src-copy-readible
[359.820813] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s)
[359.977467] [054/131] (662s left) gem_exec_balancer (full-late-pulse)
[360.048856] Starting subtest: full-late-pulse
[364.285999] Subtest full-late-pulse: SUCCESS (4.237s)
[364.646003] [055/131] (658s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[364.745318] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[364.750285] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[364.877728] [056/131] (658s left) fbdev (read)
[364.914937] Starting subtest: read
[365.438206] Subtest read: SUCCESS (0.523s)
[365.522694] [057/131] (657s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[365.622164] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[365.627342] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[365.752221] [058/131] (657s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[365.853849] Starting subtest: multiplane-rotation-cropping-top
[383.445642] Subtest multiplane-rotation-cropping-top: SUCCESS (17.594s)
[383.610124] [059/131] (639s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[383.731880] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[390.674680] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.944s)
[390.828554] [060/131] (632s left) i915_selftest (mock)
[394.321296] Starting subtest: mock
[394.323905] Starting dynamic subtest: sanitycheck
[396.274266] Dynamic subtest sanitycheck: SUCCESS (1.953s)
[396.284065] Starting dynamic subtest: shmem
[398.295800] Dynamic subtest shmem: SUCCESS (2.019s)
[398.306146] Starting dynamic subtest: fence
[407.739288] Dynamic subtest fence: SUCCESS (9.442s)
[407.748768] Starting dynamic subtest: scatterlist
[410.770689] Dynamic subtest scatterlist: SUCCESS (3.029s)
[410.780578] Starting dynamic subtest: syncmap
[415.415296] Dynamic subtest syncmap: SUCCESS (4.643s)
[415.425106] Starting dynamic subtest: uncore
[417.487771] Dynamic subtest uncore: SUCCESS (2.070s)
[417.499303] Starting dynamic subtest: ring
[419.543281] Dynamic subtest ring: SUCCESS (2.054s)
[419.558831] Starting dynamic subtest: engine
[421.631210] Dynamic subtest engine: SUCCESS (2.085s)
[421.639565] Starting dynamic subtest: timelines
[426.930555] Dynamic subtest timelines: SUCCESS (5.298s)
[426.940079] Starting dynamic subtest: requests
[432.016820] Dynamic subtest requests: SUCCESS (5.084s)
[432.026805] Starting dynamic subtest: objects
[434.238606] Dynamic subtest objects: SUCCESS (2.220s)
[434.247890] Starting dynamic subtest: phys
[436.458717] Dynamic subtest phys: SUCCESS (2.218s)
[436.467765] Starting dynamic subtest: dmabuf
[438.632047] Dynamic subtest dmabuf: SUCCESS (2.171s)
[438.642022] Starting dynamic subtest: vma
[445.334569] Dynamic subtest vma: SUCCESS (6.701s)
[445.344374] Starting dynamic subtest: evict
[448.071900] Dynamic subtest evict: SUCCESS (2.735s)
[448.081908] Starting dynamic subtest: gtt
[452.538141] Dynamic subtest gtt: SUCCESS (4.465s)
[452.547818] Starting dynamic subtest: hugepages
[454.822441] Dynamic subtest hugepages: SUCCESS (2.283s)
[454.830076] Starting dynamic subtest: memory_region
[458.671641] Dynamic subtest memory_region: SUCCESS (3.845s)
[458.674516] Subtest mock: SUCCESS (64.353s)
[458.702673] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[458.703363] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[458.706729] [061/131] (564s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[466.529468] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[466.532048] Starting dynamic subtest: pipe-A-eDP-1
[467.329759] Dynamic subtest pipe-A-eDP-1: SKIP (0.799s)
[467.339099] Starting dynamic subtest: pipe-B-eDP-1
[468.460413] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[468.465882] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.931s)
[469.685204] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[469.686384] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[469.690553] [062/131] (553s left) gem_render_copy_redux (normal)
[469.757080] Starting subtest: normal
[470.040194] Subtest normal: SUCCESS (0.283s)
[470.197752] [063/131] (553s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[470.259283] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[470.347396] [064/131] (552s left) gem_ctx_param (invalid-set-no-zeromap)
[470.409154] Starting subtest: invalid-set-no-zeromap
[470.412293] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[470.510594] [065/131] (552s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[470.615769] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[479.887620] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.273s)
[480.049240] [066/131] (543s left) i915_pm_rps (reset)
[480.105532] Starting subtest: reset
[488.557011] Subtest reset: SUCCESS (8.448s)
[488.712017] [067/131] (534s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[488.814102] Starting subtest: async-flip-with-page-flip-events-linear
[489.190088] Starting dynamic subtest: pipe-A-eDP-1
[491.933546] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.743s)
[492.298020] Starting dynamic subtest: pipe-B-eDP-1
[495.062027] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.771s)
[495.427839] Starting dynamic subtest: pipe-C-eDP-1
[498.188653] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s)
[498.550133] Starting dynamic subtest: pipe-D-eDP-1
[501.315116] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[501.318088] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.502s)
[502.529651] [068/131] (520s left) perf_pmu (module-unload)
[502.630175] Starting subtest: module-unload
[509.216827] Subtest module-unload: FAIL (6.442s)
[509.249003] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[509.249710] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[509.254025] [069/131] (514s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[512.157926] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[512.162693] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[512.245657] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[512.246852] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[512.250805] [070/131] (511s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[512.317087] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[512.422222] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[512.525557] [071/131] (511s left) kms_cursor_crc (cursor-random-256x85)
[512.759006] Starting subtest: cursor-random-256x85
[512.805657] Subtest cursor-random-256x85: SKIP (0.043s)
[513.009339] [072/131] (510s left) kms_psr (psr-sprite-plane-move)
[513.101033] Starting subtest: psr-sprite-plane-move
[513.103560] Starting dynamic subtest: eDP-1
[514.882090] Dynamic subtest eDP-1: SUCCESS (1.783s)
[514.885227] Subtest psr-sprite-plane-move: SUCCESS (1.784s)
[515.723132] [073/131] (507s left) kms_psr (fbc-pr-sprite-plane-onoff)
[515.814263] Starting subtest: fbc-pr-sprite-plane-onoff
[515.819066] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[515.912494] [074/131] (507s left) kms_pm_rpm (pm-tiling)
[520.662915] Starting subtest: pm-tiling
[520.668267] Subtest pm-tiling: SKIP (0.000s)
[521.406137] [075/131] (502s left) gem_userptr_blits (invalid-null-pointer)
[521.482176] Starting subtest: invalid-null-pointer
[521.484840] Subtest invalid-null-pointer: SUCCESS (0.001s)
[521.654209] [076/131] (502s left) kms_content_protection (lic-type-1)
[521.805508] Starting subtest: lic-type-1
[521.810761] Subtest lic-type-1: SKIP (0.000s)
[521.967631] [077/131] (501s left) kms_atomic (plane-immutable-zpos)
[522.048568] Starting subtest: plane-immutable-zpos
[522.050927] Starting dynamic subtest: pipe-A-eDP-1
[522.697268] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.644s)
[522.700171] Subtest plane-immutable-zpos: SUCCESS (0.646s)
[523.522377] [078/131] (500s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[523.650832] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[523.655568] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[523.833018] [079/131] (500s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[523.931819] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[523.934454] Starting dynamic subtest: pipe-A
[525.001619] Dynamic subtest pipe-A: SUCCESS (1.072s)
[525.010117] Starting dynamic subtest: pipe-B
[527.109573] Dynamic subtest pipe-B: SUCCESS (2.107s)
[527.118108] Starting dynamic subtest: pipe-C
[528.305087] Dynamic subtest pipe-C: SUCCESS (1.193s)
[528.313082] Starting dynamic subtest: pipe-D
[529.453049] Dynamic subtest pipe-D: SUCCESS (1.147s)
[529.455657] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.525s)
[530.673834] [080/131] (493s left) kms_psr (pr-sprite-mmap-cpu)
[530.774300] Starting subtest: pr-sprite-mmap-cpu
[530.779947] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[530.887343] [081/131] (493s left) gem_ctx_persistence (legacy-engines-cleanup)
[530.965412] Starting subtest: legacy-engines-cleanup
[530.967895] Starting dynamic subtest: render
[531.084208] Dynamic subtest render: SUCCESS (0.122s)
[531.097932] Starting dynamic subtest: bsd1
[531.150585] Dynamic subtest bsd1: SUCCESS (0.063s)
[531.166124] Starting dynamic subtest: bsd2
[531.223526] Dynamic subtest bsd2: SUCCESS (0.070s)
[531.234995] Starting dynamic subtest: blt
[531.289475] Dynamic subtest blt: SUCCESS (0.063s)
[531.301554] Starting dynamic subtest: vebox
[531.355556] Dynamic subtest vebox: SUCCESS (0.063s)
[531.358198] Subtest legacy-engines-cleanup: SUCCESS (0.395s)
[531.462139] [082/131] (492s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[531.583917] Starting subtest: cursor-tearing-framebuffer-change
[531.586015] Starting dynamic subtest: pipe-A-eDP-1
[532.161290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[532.170086] Starting dynamic subtest: pipe-D-eDP-1
[533.367098] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.203s)
[533.370114] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.783s)
[534.230579] [083/131] (489s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[534.356918] Starting subtest: 2x-cursor-vs-flip-atomic
[534.362070] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[534.538938] [084/131] (489s left) kms_cursor_crc (cursor-random-32x10)
[534.716023] Starting subtest: cursor-random-32x10
[534.760030] Subtest cursor-random-32x10: SKIP (0.038s)
[535.043643] [085/131] (489s left) kms_psr (fbc-psr-primary-mmap-gtt)
[535.133127] Starting subtest: fbc-psr-primary-mmap-gtt
[535.135746] Starting dynamic subtest: eDP-1
[535.139913] Dynamic subtest eDP-1: SKIP (0.000s)
[535.143984] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[535.234624] [086/131] (488s left) kms_big_fb (linear-8bpp-rotate-0)
[535.350124] Starting subtest: linear-8bpp-rotate-0
[536.643019] Subtest linear-8bpp-rotate-0: SUCCESS (1.291s)
[536.802512] [087/131] (487s left) gem_create (create-ext-cpu-access-sanity-check)
[536.974475] Starting subtest: create-ext-cpu-access-sanity-check
[536.979581] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[537.074659] [088/131] (487s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[537.176525] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[541.335977] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.163s)
[542.512345] [089/131] (481s left) kms_pm_rpm (cursor-dpms)
[544.639906] Starting subtest: cursor-dpms
[544.644948] Subtest cursor-dpms: SKIP (0.000s)
[545.036567] [090/131] (479s left) gem_lmem_swapping (verify-random-ccs)
[545.092286] Subtest verify-random-ccs: SKIP (0.000s)
[545.140068] [091/131] (479s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[545.266735] Starting subtest: flip-vs-cursor-toggle
[553.681182] Subtest flip-vs-cursor-toggle: SUCCESS (8.414s)
[554.554340] [092/131] (469s left) gem_lmem_swapping (heavy-verify-multi)
[554.602086] Subtest heavy-verify-multi: SKIP (0.000s)
[554.647691] [093/131] (469s left) i915_pm_freq_api (freq-reset)
[554.715213] Starting subtest: freq-reset
[554.718104] Starting dynamic subtest: gt0
[554.912900] Dynamic subtest gt0: SUCCESS (0.195s)
[554.923507] Starting dynamic subtest: gt1
[555.076174] Dynamic subtest gt1: SUCCESS (0.163s)
[555.079332] Subtest freq-reset: SUCCESS (0.360s)
[555.175650] [094/131] (469s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[555.286401] Starting subtest: y-tiled-64bpp-rotate-90
[555.291528] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[555.413817] [095/131] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[555.518330] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[555.523199] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[555.625011] [096/131] (469s left) kms_dirtyfb (default-dirtyfb-ioctl)
[555.724406] Starting subtest: default-dirtyfb-ioctl
[555.726743] Starting dynamic subtest: A-eDP-1
[557.372757] Dynamic subtest A-eDP-1: SUCCESS (1.647s)
[557.375434] Subtest default-dirtyfb-ioctl: SUCCESS (1.649s)
[558.193645] [097/131] (466s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[558.289908] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[558.292363] Starting dynamic subtest: pipe-A
[558.629179] Dynamic subtest pipe-A: SUCCESS (0.342s)
[558.638294] Starting dynamic subtest: pipe-B
[560.074741] Dynamic subtest pipe-B: SUCCESS (1.445s)
[560.086132] Starting dynamic subtest: pipe-C
[561.511556] Dynamic subtest pipe-C: SUCCESS (1.435s)
[561.527016] Starting dynamic subtest: pipe-D
[562.944121] Dynamic subtest pipe-D: SUCCESS (1.431s)
[562.947081] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.658s)
[564.136692] [098/131] (460s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[564.227920] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[564.230127] Starting dynamic subtest: pipe-A-default-mode
[564.543014] Dynamic subtest pipe-A-default-mode: SKIP (0.314s)
[564.548001] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.315s)
[565.358626] [099/131] (459s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[565.475301] Starting subtest: 2x-cursor-vs-flip-legacy
[565.479899] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[565.644854] [100/131] (459s left) gem_readwrite (write-bad-handle)
[565.711162] Subtest write-bad-handle: SKIP (0.000s)
[565.771213] [101/131] (459s left) gem_reg_read (timestamp-monotonic)
[565.826767] Starting subtest: timestamp-monotonic
[569.963805] Subtest timestamp-monotonic: SUCCESS (4.138s)
[570.067255] [102/131] (454s left) kms_psr (fbc-psr2-cursor-plane-move)
[570.171022] Starting subtest: fbc-psr2-cursor-plane-move
[570.173933] Starting dynamic subtest: eDP-1
[570.179114] Dynamic subtest eDP-1: SKIP (0.000s)
[570.184350] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[570.272655] [103/131] (454s left) kms_plane_lowres (tiling-x)
[570.365714] Starting subtest: tiling-x
[570.368124] Starting dynamic subtest: pipe-A-eDP-1
[570.372734] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[570.657052] Starting dynamic subtest: pipe-B-eDP-1
[570.661959] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[570.670885] Starting dynamic subtest: pipe-C-eDP-1
[570.675649] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[570.685218] Starting dynamic subtest: pipe-D-eDP-1
[570.690052] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[570.694760] Subtest tiling-x: SKIP (0.291s)
[571.493907] [104/131] (453s left) kms_force_connector_basic (force-edid)
[571.578197] Starting subtest: force-edid
[571.939180] Subtest force-edid: SUCCESS (0.364s)
[572.103835] [105/131] (452s left) kms_getfb (getfb-handle-zero)
[572.197197] Starting subtest: getfb-handle-zero
[572.199944] Subtest getfb-handle-zero: SUCCESS (0.000s)
[572.334338] [106/131] (452s left) perf (missing-sample-flags)
[572.468835] Starting subtest: missing-sample-flags
[572.470955] Subtest missing-sample-flags: SUCCESS (0.000s)
[572.512663] [107/131] (452s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[572.601571] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[579.165025] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.565s)
[579.312855] [108/131] (445s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[579.411057] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[579.416160] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[579.528521] [109/131] (445s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[579.630326] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[579.635057] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[579.756389] [110/131] (445s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[579.857173] Starting subtest: 4-tiled-8bpp-rotate-180
[581.102969] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.247s)
[581.257328] [111/131] (444s left) gem_exec_fence (syncobj-timeline-repeat)
[581.797123] Starting subtest: syncobj-timeline-repeat
[582.023930] Subtest syncobj-timeline-repeat: SUCCESS (0.227s)
[583.637522] [112/131] (441s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[583.735804] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[590.930053] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.199s)
[591.104361] [113/131] (434s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[591.167661] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[591.170037] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[591.305642] [114/131] (434s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[591.403419] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[595.087709] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.688s)
[596.234770] [115/131] (429s left) gem_exec_schedule (lateslice)
[596.318007] Starting subtest: lateslice
[596.320095] Starting dynamic subtest: rcs0
[596.329161] Dynamic subtest rcs0: SUCCESS (0.023s)
[596.338201] Starting dynamic subtest: bcs0
[596.346784] Dynamic subtest bcs0: SUCCESS (0.017s)
[596.355441] Starting dynamic subtest: vcs0
[596.367236] Dynamic subtest vcs0: SUCCESS (0.020s)
[596.375824] Starting dynamic subtest: vcs1
[596.385735] Dynamic subtest vcs1: SUCCESS (0.018s)
[596.394569] Starting dynamic subtest: vecs0
[596.403250] Dynamic subtest vecs0: SUCCESS (0.017s)
[596.411803] Starting dynamic subtest: ccs0
[596.419999] Dynamic subtest ccs0: SUCCESS (0.016s)
[596.422314] Subtest lateslice: SUCCESS (0.115s)
[597.651645] [116/131] (427s left) kms_vblank (query-idle-hang)
[597.745927] Starting subtest: query-idle-hang
[597.748726] Starting dynamic subtest: pipe-A-eDP-1
[624.271697] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.524s)
[624.287140] Starting dynamic subtest: pipe-D-eDP-1
[649.253217] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.977s)
[649.256295] Subtest query-idle-hang: SUCCESS (51.506s)
[650.106271] [117/131] (375s left) syncobj_wait (reset-multiple-signaled)
[650.166133] Starting subtest: reset-multiple-signaled
[650.169171] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[650.287837] [118/131] (375s left) kms_flip_event_leak (basic)
[650.387056] Starting subtest: basic
[650.389496] Starting dynamic subtest: pipe-A-eDP-1
[650.803956] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[650.814854] Starting dynamic subtest: pipe-B-eDP-1
[651.969863] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.165s)
[651.978886] Starting dynamic subtest: pipe-C-eDP-1
[653.053485] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.083s)
[653.064039] Starting dynamic subtest: pipe-D-eDP-1
[654.138179] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.084s)
[654.141165] Subtest basic: SUCCESS (3.755s)
[655.010131] [119/131] (370s left) gem_pwrite_snooped
[655.136049] [120/131] (370s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[655.189770] Starting subtest: yf-tiled-ccs-to-y-tiled
[655.195119] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[655.398677] [121/131] (370s left) gem_ctx_shared (q-independent)
[655.473946] Starting subtest: Q-independent
[655.476289] Starting dynamic subtest: rcs0
[655.544177] Dynamic subtest rcs0: SUCCESS (0.073s)
[655.557517] Starting dynamic subtest: vcs0
[655.587310] Dynamic subtest vcs0: SUCCESS (0.042s)
[655.597774] Starting dynamic subtest: vcs1
[655.625832] Dynamic subtest vcs1: SUCCESS (0.038s)
[655.635828] Starting dynamic subtest: vecs0
[655.663144] Dynamic subtest vecs0: SUCCESS (0.037s)
[655.673328] Starting dynamic subtest: ccs0
[655.704895] Dynamic subtest ccs0: SUCCESS (0.041s)
[655.707902] Subtest Q-independent: SUCCESS (0.234s)
[657.619577] [122/131] (368s left) prime_mmap (test_userptr)
[657.674190] Starting subtest: test_userptr
[657.677186] Starting dynamic subtest: test_userptr-smem
[657.679561] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[657.682266] Subtest test_userptr: SUCCESS (0.001s)
[657.789695] [123/131] (367s left) kms_addfb_basic (bad-pitch-65536)
[657.852702] Starting subtest: bad-pitch-65536
[657.854820] Subtest bad-pitch-65536: SUCCESS (0.000s)
[658.021981] [124/131] (367s left) prime_self_import (basic-with_fd_dup)
[658.061534] Starting subtest: basic-with_fd_dup
[658.088294] Subtest basic-with_fd_dup: SUCCESS (0.026s)
[658.219846] [125/131] (367s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[658.324484] Starting subtest: primary-y-tiled-reflect-x-0
[658.400128] Subtest primary-y-tiled-reflect-x-0: SKIP (0.075s)
[658.523529] [126/131] (367s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[658.615898] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[658.617934] Starting dynamic subtest: pipe-A-eDP-1
[658.637425] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[658.647441] Starting dynamic subtest: pipe-B-eDP-1
[658.668424] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[658.677537] Starting dynamic subtest: pipe-C-eDP-1
[658.698026] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[658.706706] Starting dynamic subtest: pipe-D-eDP-1
[658.728258] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[658.732527] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[660.894415] [127/131] (365s left) kms_addfb_basic (unused-modifier)
[660.969014] Starting subtest: unused-modifier
[660.971979] Subtest unused-modifier: SUCCESS (0.000s)
[661.140758] [128/131] (364s left) kms_vblank (wait-idle)
[661.241178] Starting subtest: wait-idle
[661.243883] Starting dynamic subtest: pipe-A-eDP-1
[662.998775] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.758s)
[663.015446] Starting dynamic subtest: pipe-D-eDP-1
[665.485572] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.483s)
[665.488138] Subtest wait-idle: SUCCESS (4.246s)
[666.307887] [129/131] (359s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[666.436873] Starting subtest: cursorA-vs-flipA-toggle
[677.563064] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.127s)
[678.403141] [130/131] (347s left) gen9_exec_parse (bb-start-far)
[678.469879] Subtest bb-start-far: SKIP (0.000s)
[678.553969] [131/131] (347s left) kms_addfb_basic (basic)
[678.617127] Starting subtest: basic
[678.620011] Subtest basic: SUCCESS (0.000s)
[678.795528] Closing watchdogs
results: parsing output: 0/ for test: syncobj_eventfd
results: parsing output: 1/ for test: tools_test
results: parsing output: 2/ for test: kms_psr2_su
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_pipe_stress
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_atomic_interruptible
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: gem_mmap_offset
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: core_getstats
results: parsing output: 25/ for test: core_getclient
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_invalid_mode
results: parsing output: 29/ for test: gem_mmap_offset
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_exec_suspend
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_chamelium_frames
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: kms_legacy_colorkey
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: gem_tiled_wb
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: gem_ctx_param
results: parsing output: 44/ for test: kms_color_pipeline
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_feature_discovery
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: gem_pxp
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: fbdev
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_rotation_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_selftest
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gem_render_copy_redux
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: gem_ctx_param
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: i915_pm_rps
results: parsing output: 66/ for test: kms_async_flips
results: parsing output: 67/ for test: perf_pmu
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_pm_rpm
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: kms_content_protection
results: parsing output: 76/ for test: kms_atomic
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_create
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: gem_lmem_swapping
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: gem_lmem_swapping
results: parsing output: 92/ for test: i915_pm_freq_api
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_dirtyfb
results: parsing output: 96/ for test: kms_plane_scaling
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: gem_readwrite
results: parsing output: 100/ for test: gem_reg_read
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_plane_lowres
results: parsing output: 103/ for test: kms_force_connector_basic
results: parsing output: 104/ for test: kms_getfb
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_flip_event_leak
results: parsing output: 118/ for test: gem_pwrite_snooped
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: gem_ctx_shared
results: parsing output: 121/ for test: prime_mmap
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: prime_self_import
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_addfb_basic
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: gen9_exec_parse
results: parsing output: 130/ for test: kms_addfb_basic
Done.