[58.603333] Initializing watchdogs
[58.603379]   /dev/watchdog0
[58.620650] [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]
[58.624907] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.627059] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.630597] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[58.709898] Starting subtest: invalid-bad-pad
[58.712313] Subtest invalid-bad-pad: SUCCESS (0.000s)
[58.836777] [002/131] (960s left) tools_test (tools_test)
[58.894055] Starting subtest: tools_test
[58.942549] Subtest tools_test: SUCCESS (0.064s)
[59.029828] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[59.091299] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[59.151091] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[59.228913] Starting subtest: sync-unmap-cycles
[64.599852] Subtest sync-unmap-cycles: SUCCESS (5.373s)
[64.781603] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[64.884400] Starting subtest: stress-xrgb8888-ytiled
[64.888096] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[64.957419] [006/131] (954s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[65.044779] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[65.046867] Starting dynamic subtest: pipe-A-eDP-1
[81.564421] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.724s)
[81.573603] Starting dynamic subtest: pipe-B-eDP-1
[98.586841] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.459s)
[98.596046] Starting dynamic subtest: pipe-C-eDP-1
[115.517147] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.378s)
[115.530109] Starting dynamic subtest: pipe-D-eDP-1
[132.496498] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.341s)
[132.498528] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (12.905s)
[133.763334] [007/131] (885s left) api_intel_allocator (gem-pool)
[133.826360] Starting subtest: gem-pool
[133.832051] Subtest gem-pool: SUCCESS (0.008s)
[133.948491] [008/131] (885s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[134.051408] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[140.586463] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.541s)
[140.731500] [009/131] (878s left) kms_atomic_interruptible (universal-setplane-primary)
[140.829099] Starting subtest: universal-setplane-primary
[140.831332] Starting dynamic subtest: pipe-A-eDP-1
[148.264089] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.435s)
[148.266546] Subtest universal-setplane-primary: SUCCESS (7.437s)
[149.126762] [010/131] (870s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[149.228158] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[153.477345] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.253s)
[154.631583] [011/131] (864s left) gem_eio (in-flight-contexts-1us)
[154.844426] Starting subtest: in-flight-contexts-1us
[166.460215] Subtest in-flight-contexts-1us: SUCCESS (11.616s)
[166.682674] [012/131] (852s left) gem_exec_balancer (semaphore)
[166.757695] Starting subtest: semaphore
[168.465494] Subtest semaphore: SUCCESS (1.706s)
[168.806487] [013/131] (850s left) kms_chamelium_hpd (hdmi-hpd)
[169.192735] Subtest hdmi-hpd: SKIP (0.000s)
[170.011263] [014/131] (849s left) kms_flip (wf_vblank-ts-check)
[170.136605] Starting subtest: wf_vblank-ts-check
[170.138942] Starting dynamic subtest: A-eDP1
[179.071850] Dynamic subtest A-eDP1: SUCCESS (8.934s)
[179.081111] Starting dynamic subtest: B-eDP1
[187.994143] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[188.002689] Starting dynamic subtest: C-eDP1
[196.918041] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[196.930582] Starting dynamic subtest: D-eDP1
[205.846995] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[205.849220] Subtest wf_vblank-ts-check: SUCCESS (35.717s)
[207.091239] [015/131] (812s left) gem_exec_reloc (basic-gtt)
[207.167978] Subtest basic-gtt: SKIP (0.000s)
[207.252172] [016/131] (812s left) gem_exec_schedule (reorder-wide)
[207.433739] Subtest reorder-wide: SKIP (0.000s)
[207.635337] [017/131] (812s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[207.737156] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[207.739645] Starting dynamic subtest: pipe-A-eDP-1
[207.763344] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[207.781480] Starting dynamic subtest: pipe-B-eDP-1
[207.803715] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[207.821132] Starting dynamic subtest: pipe-C-eDP-1
[207.843592] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[207.860883] Starting dynamic subtest: pipe-D-eDP-1
[207.883796] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[207.887927] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[210.042275] [018/131] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[210.152906] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[210.157126] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[210.255854] [019/131] (809s left) perf (polling)
[210.397260] Starting subtest: polling
[210.399185] Starting dynamic subtest: 0-rcs0
[220.409345] Dynamic subtest 0-rcs0: SUCCESS (10.013s)
[220.418086] Starting dynamic subtest: 1-vecs0
[230.435102] Dynamic subtest 1-vecs0: SUCCESS (10.024s)
[230.437575] Subtest polling: SUCCESS (20.038s)
[230.480978] [020/131] (789s left) gem_userptr_blits (probe)
[230.559717] Starting subtest: probe
[230.630961] Subtest probe: SUCCESS (0.071s)
[230.781605] [021/131] (789s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[230.905623] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[230.910273] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[231.038760] [022/131] (788s left) gem_mmap_offset (pf-nonblock)
[231.088201] Starting subtest: pf-nonblock
[231.092694] Subtest pf-nonblock: SUCCESS (0.006s)
[231.245526] [023/131] (788s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[231.345046] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[231.347290] Starting dynamic subtest: pipe-A-eDP-1
[231.372342] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[231.382438] Starting dynamic subtest: pipe-B-eDP-1
[231.405141] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[231.413175] Starting dynamic subtest: pipe-C-eDP-1
[231.437058] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[231.445259] Starting dynamic subtest: pipe-D-eDP-1
[231.466011] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[231.469530] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[233.599954] [024/131] (786s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[233.709704] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[233.713780] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[233.846880] [025/131] (786s left) core_getstats (basic)
[233.904145] Starting subtest: basic
[233.905990] Subtest basic: SUCCESS (0.000s)
[234.024557] [026/131] (786s left) core_getclient (basic)
[234.082578] Starting subtest: basic
[234.084561] Subtest basic: SUCCESS (0.000s)
[234.219196] [027/131] (785s left) syncobj_timeline (multi-wait-all-available-submitted)
[234.286174] Starting subtest: multi-wait-all-available-submitted
[234.288619] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[234.411601] [028/131] (785s left) gem_exec_reloc (basic-write-wc)
[234.481109] Subtest basic-write-wc: SKIP (0.000s)
[234.553703] [029/131] (785s left) kms_invalid_mode (clock-too-high)
[234.653243] Starting subtest: clock-too-high
[234.655453] Starting dynamic subtest: pipe-A-eDP-1
[234.659037] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[234.667390] Starting dynamic subtest: pipe-B-eDP-1
[234.671090] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[234.679028] Starting dynamic subtest: pipe-C-eDP-1
[234.682543] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[234.690241] Starting dynamic subtest: pipe-D-eDP-1
[234.693639] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[234.696957] Subtest clock-too-high: SKIP (0.004s)
[234.748227] [030/131] (785s left) gem_mmap_offset (bad-object)
[234.807189] Starting subtest: bad-object
[234.809130] Subtest bad-object: SUCCESS (0.001s)
[234.943153] [031/131] (785s left) syncobj_timeline (wait-all-delayed-signal)
[234.999449] Starting subtest: wait-all-delayed-signal
[235.102355] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[235.202090] [032/131] (785s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[235.310879] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[235.979923] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s)
[236.202220] [033/131] (784s left) gem_exec_suspend (basic-s3)
[236.271577] Starting subtest: basic-S3
[236.273557] Starting dynamic subtest: smem
[256.262642] Dynamic subtest smem: SUCCESS (6.130s)
[256.265609] Subtest basic-S3: SUCCESS (6.131s)
[256.472654] [034/131] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[256.606395] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[256.612198] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[256.741601] [035/131] (763s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[256.848269] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[256.853469] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[256.980228] [036/131] (763s left) kms_chamelium_frames (hdmi-crc-multiple)
[257.369856] Subtest hdmi-crc-multiple: SKIP (0.000s)
[258.143901] [037/131] (762s left) gem_exec_fence (syncobj-import)
[258.630479] Starting subtest: syncobj-import
[258.636601] Subtest syncobj-import: SUCCESS (0.006s)
[260.397706] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[260.401333] [038/131] (760s left) kms_legacy_colorkey (basic)
[260.496337] Starting subtest: basic
[260.499045] Starting dynamic subtest: pipe-A
[260.541509] Dynamic subtest pipe-A: SUCCESS (0.045s)
[260.552458] Starting dynamic subtest: pipe-B
[260.555198] Dynamic subtest pipe-B: SUCCESS (0.001s)
[260.564278] Starting dynamic subtest: pipe-C
[260.567018] Dynamic subtest pipe-C: SUCCESS (0.000s)
[260.575462] Starting dynamic subtest: pipe-D
[260.578275] Dynamic subtest pipe-D: SUCCESS (0.000s)
[260.581247] Subtest basic: SUCCESS (0.051s)
[260.637070] [039/131] (759s left) gem_softpin (allocator-nopin-reserve)
[260.704034] Starting subtest: allocator-nopin-reserve
[260.804283] Subtest allocator-nopin-reserve: SUCCESS (0.100s)
[260.967472] [040/131] (759s left) perf_pmu (enable-race)
[261.013767] Starting subtest: enable-race
[261.016379] Starting dynamic subtest: rcs0
[273.762271] Dynamic subtest rcs0: SUCCESS (12.749s)
[273.773722] Starting dynamic subtest: bcs0
[286.502848] Dynamic subtest bcs0: SUCCESS (12.739s)
[286.512604] Starting dynamic subtest: vcs0
[302.279251] Dynamic subtest vcs0: SUCCESS (15.773s)
[302.291122] Starting dynamic subtest: vcs1
[318.279321] Dynamic subtest vcs1: SUCCESS (15.997s)
[318.290800] Starting dynamic subtest: vecs0
[334.278376] Dynamic subtest vecs0: SUCCESS (15.996s)
[334.288338] Starting dynamic subtest: ccs0
[347.023053] Dynamic subtest ccs0: SUCCESS (12.743s)
[347.025485] Subtest enable-race: SUCCESS (86.006s)
[347.164955] [041/131] (673s left) syncobj_timeline (signal-point-0)
[347.225437] Starting subtest: signal-point-0
[347.228312] Subtest signal-point-0: SUCCESS (0.000s)
[347.362775] [042/131] (673s left) gem_tiled_wb
[347.480226] [043/131] (673s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[347.576157] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[347.578635] Starting dynamic subtest: pipe-A-eDP-1
[347.603695] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[347.612592] Starting dynamic subtest: pipe-B-eDP-1
[347.637111] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[347.645013] Starting dynamic subtest: pipe-C-eDP-1
[347.669650] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[347.677253] Starting dynamic subtest: pipe-D-eDP-1
[347.702371] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[347.707077] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[349.760229] [044/131] (671s left) gem_ctx_param (set-priority-invalid-size)
[349.808592] Starting subtest: set-priority-invalid-size
[349.811373] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[349.907352] [045/131] (670s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[349.996894] Starting subtest: plane-ctm3x4-lut1d
[350.009314] Starting dynamic subtest: pipe-A-eDP-1
[350.762142] Dynamic subtest pipe-A-eDP-1: FAIL (0.314s)
[351.412069] Starting dynamic subtest: pipe-B-eDP-1
[352.343136] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[352.841224] Starting dynamic subtest: pipe-C-eDP-1
[353.745845] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[354.158285] Starting dynamic subtest: pipe-D-eDP-1
[355.116910] Dynamic subtest pipe-D-eDP-1: FAIL (0.278s)
[355.119359] Subtest plane-ctm3x4-lut1d: FAIL (4.733s)
[355.567713] [046/131] (665s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[355.695609] Starting subtest: 2x-long-cursor-vs-flip-atomic
[355.700943] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[355.859619] [047/131] (665s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[355.958499] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[355.963279] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[356.074299] [048/131] (664s left) kms_feature_discovery (display-1x)
[356.168223] Starting subtest: display-1x
[356.170342] Subtest display-1x: SUCCESS (0.000s)
[356.264498] [049/131] (664s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[356.372976] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[356.378079] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[356.506563] [050/131] (664s left) i915_drm_fdinfo (most-busy-idle-check-all)
[356.550703] Starting subtest: most-busy-idle-check-all
[356.552300] Starting dynamic subtest: rcs0
[356.556158] Dynamic subtest rcs0: SKIP (0.004s)
[356.564827] Starting dynamic subtest: bcs0
[356.568615] Dynamic subtest bcs0: SKIP (0.000s)
[356.576737] Starting dynamic subtest: vcs0
[356.580659] Dynamic subtest vcs0: SKIP (0.000s)
[356.588772] Starting dynamic subtest: vcs1
[356.593312] Dynamic subtest vcs1: SKIP (0.000s)
[356.601522] Starting dynamic subtest: vecs0
[356.605765] Dynamic subtest vecs0: SKIP (0.000s)
[356.613614] Starting dynamic subtest: ccs0
[356.617490] Dynamic subtest ccs0: SKIP (0.000s)
[356.622256] Subtest most-busy-idle-check-all: SKIP (0.008s)
[356.659523] [051/131] (664s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[356.768463] Starting subtest: x-tiled-32bpp-rotate-270
[356.789791] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[356.946765] [052/131] (664s left) gem_exec_schedule (u-submit-early-slice)
[357.025037] Starting subtest: u-submit-early-slice
[357.027164] Starting dynamic subtest: rcs0
[357.064949] Dynamic subtest rcs0: SUCCESS (0.048s)
[357.076515] Starting dynamic subtest: bcs0
[357.100801] Dynamic subtest bcs0: SUCCESS (0.035s)
[357.109347] Starting dynamic subtest: vcs0
[357.144024] Dynamic subtest vcs0: SUCCESS (0.043s)
[357.152866] Starting dynamic subtest: vcs1
[357.188382] Dynamic subtest vcs1: SUCCESS (0.043s)
[357.199303] Starting dynamic subtest: vecs0
[357.222241] Dynamic subtest vecs0: SUCCESS (0.033s)
[357.231948] Starting dynamic subtest: ccs0
[357.255767] Dynamic subtest ccs0: SUCCESS (0.032s)
[357.257952] Subtest u-submit-early-slice: SUCCESS (0.239s)
[358.414479] [053/131] (662s left) gem_pxp (regular-baseline-src-copy-readible)
[358.531224] Starting subtest: regular-baseline-src-copy-readible
[358.587940] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[358.725104] [054/131] (662s left) gem_exec_balancer (full-late-pulse)
[358.790450] Starting subtest: full-late-pulse
[363.186671] Subtest full-late-pulse: SUCCESS (4.396s)
[363.544888] [055/131] (657s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[363.650273] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[363.655163] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[363.771609] [056/131] (657s left) fbdev (read)
[363.818844] Starting subtest: read
[364.699967] Subtest read: SUCCESS (0.881s)
[364.789326] [057/131] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[364.895308] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[364.900381] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[365.028899] [058/131] (656s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[365.126019] Starting subtest: multiplane-rotation-cropping-top
[382.528017] Subtest multiplane-rotation-cropping-top: SUCCESS (17.404s)
[382.691640] [059/131] (638s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[382.806896] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[389.824250] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.021s)
[390.012693] [060/131] (631s left) i915_selftest (mock)
[393.531482] Starting subtest: mock
[393.534147] Starting dynamic subtest: sanitycheck
[395.443050] Dynamic subtest sanitycheck: SUCCESS (1.915s)
[395.458286] Starting dynamic subtest: shmem
[397.405401] Dynamic subtest shmem: SUCCESS (1.960s)
[397.415449] Starting dynamic subtest: fence
[406.558648] Dynamic subtest fence: SUCCESS (9.150s)
[406.573197] Starting dynamic subtest: scatterlist
[409.612697] Dynamic subtest scatterlist: SUCCESS (3.052s)
[409.621946] Starting dynamic subtest: syncmap
[414.312020] Dynamic subtest syncmap: SUCCESS (4.697s)
[414.321890] Starting dynamic subtest: uncore
[416.367042] Dynamic subtest uncore: SUCCESS (2.053s)
[416.376884] Starting dynamic subtest: ring
[418.349127] Dynamic subtest ring: SUCCESS (1.980s)
[418.358897] Starting dynamic subtest: engine
[420.377867] Dynamic subtest engine: SUCCESS (2.027s)
[420.387975] Starting dynamic subtest: timelines
[425.388902] Dynamic subtest timelines: SUCCESS (5.009s)
[425.398868] Starting dynamic subtest: requests
[430.151768] Dynamic subtest requests: SUCCESS (4.761s)
[430.161342] Starting dynamic subtest: objects
[432.292935] Dynamic subtest objects: SUCCESS (2.139s)
[432.302740] Starting dynamic subtest: phys
[434.407829] Dynamic subtest phys: SUCCESS (2.113s)
[434.417727] Starting dynamic subtest: dmabuf
[436.607156] Dynamic subtest dmabuf: SUCCESS (2.197s)
[436.616772] Starting dynamic subtest: vma
[443.242218] Dynamic subtest vma: SUCCESS (6.633s)
[443.252395] Starting dynamic subtest: evict
[445.916401] Dynamic subtest evict: SUCCESS (2.672s)
[445.925856] Starting dynamic subtest: gtt
[450.289165] Dynamic subtest gtt: SUCCESS (4.371s)
[450.298210] Starting dynamic subtest: hugepages
[452.464094] Dynamic subtest hugepages: SUCCESS (2.174s)
[452.471846] Starting dynamic subtest: memory_region
[456.206326] Dynamic subtest memory_region: SUCCESS (3.740s)
[456.209188] Subtest mock: SUCCESS (62.677s)
[456.239584] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[456.240312] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[456.243893] [061/131] (565s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[464.033468] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[464.036378] Starting dynamic subtest: pipe-A-eDP-1
[464.825950] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[464.834788] Starting dynamic subtest: pipe-B-eDP-1
[465.951921] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s)
[465.957283] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.918s)
[467.151305] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[467.153156] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[467.157273] [062/131] (554s left) gem_render_copy_redux (normal)
[467.222304] Starting subtest: normal
[467.504354] Subtest normal: SUCCESS (0.281s)
[467.658941] [063/131] (553s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[467.725332] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[467.799785] [064/131] (553s left) gem_ctx_param (invalid-set-no-zeromap)
[467.856113] Starting subtest: invalid-set-no-zeromap
[467.858731] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[467.953488] [065/131] (553s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[468.054342] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[477.064597] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.012s)
[477.214278] [066/131] (544s left) i915_pm_rps (reset)
[477.283153] Starting subtest: reset
[485.750393] Subtest reset: SUCCESS (8.464s)
[485.912702] [067/131] (535s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[486.010959] Starting subtest: async-flip-with-page-flip-events-linear
[486.382392] Starting dynamic subtest: pipe-A-eDP-1
[489.196135] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.812s)
[489.574485] Starting dynamic subtest: pipe-B-eDP-1
[492.321689] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s)
[492.681176] Starting dynamic subtest: pipe-C-eDP-1
[495.449751] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.774s)
[495.810325] Starting dynamic subtest: pipe-D-eDP-1
[498.575936] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[498.578508] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.566s)
[499.786479] [068/131] (522s left) perf_pmu (module-unload)
[499.874473] Starting subtest: module-unload
[506.517281] Subtest module-unload: FAIL (6.504s)
[506.550304] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[506.551019] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[506.554532] [069/131] (515s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[509.496585] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[509.501357] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[509.603906] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[509.605050] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[509.608841] [070/131] (512s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[509.670262] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[509.778384] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[509.877440] [071/131] (512s left) kms_cursor_crc (cursor-random-256x85)
[510.157225] Starting subtest: cursor-random-256x85
[510.211560] Subtest cursor-random-256x85: SKIP (0.047s)
[510.421875] [072/131] (511s left) kms_psr (psr-sprite-plane-move)
[510.521400] Starting subtest: psr-sprite-plane-move
[510.523930] Starting dynamic subtest: eDP-1
[512.340832] Dynamic subtest eDP-1: SUCCESS (1.821s)
[512.343468] Subtest psr-sprite-plane-move: SUCCESS (1.822s)
[513.180909] [073/131] (508s left) kms_psr (fbc-pr-sprite-plane-onoff)
[513.282351] Starting subtest: fbc-pr-sprite-plane-onoff
[513.287106] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[513.380768] [074/131] (508s left) kms_pm_rpm (pm-tiling)
[515.515684] Starting subtest: pm-tiling
[515.521319] Subtest pm-tiling: SKIP (0.000s)
[515.873584] [075/131] (506s left) gem_userptr_blits (invalid-null-pointer)
[515.945778] Starting subtest: invalid-null-pointer
[515.948340] Subtest invalid-null-pointer: SUCCESS (0.001s)
[516.119155] [076/131] (506s left) kms_content_protection (lic-type-1)
[516.279473] Starting subtest: lic-type-1
[516.285242] Subtest lic-type-1: SKIP (0.000s)
[516.451430] [077/131] (505s left) kms_atomic (plane-immutable-zpos)
[516.545183] Starting subtest: plane-immutable-zpos
[516.547912] Starting dynamic subtest: pipe-A-eDP-1
[517.175325] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.629s)
[517.178123] Subtest plane-immutable-zpos: SUCCESS (0.630s)
[518.025325] [078/131] (504s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[518.148155] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[518.153466] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[518.319316] [079/131] (503s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[518.413103] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[518.415649] Starting dynamic subtest: pipe-A
[519.462327] Dynamic subtest pipe-A: SUCCESS (1.050s)
[519.470717] Starting dynamic subtest: pipe-B
[521.599940] Dynamic subtest pipe-B: SUCCESS (2.139s)
[521.608325] Starting dynamic subtest: pipe-C
[522.789393] Dynamic subtest pipe-C: SUCCESS (1.187s)
[522.798457] Starting dynamic subtest: pipe-D
[523.924206] Dynamic subtest pipe-D: SUCCESS (1.134s)
[523.926971] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.514s)
[525.150542] [080/131] (497s left) kms_psr (pr-sprite-mmap-cpu)
[525.252747] Starting subtest: pr-sprite-mmap-cpu
[525.258071] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[525.350299] [081/131] (497s left) gem_ctx_persistence (legacy-engines-cleanup)
[525.426446] Starting subtest: legacy-engines-cleanup
[525.429174] Starting dynamic subtest: render
[525.536094] Dynamic subtest render: SUCCESS (0.110s)
[525.550104] Starting dynamic subtest: bsd1
[525.602580] Dynamic subtest bsd1: SUCCESS (0.063s)
[525.614378] Starting dynamic subtest: bsd2
[525.672482] Dynamic subtest bsd2: SUCCESS (0.067s)
[525.683973] Starting dynamic subtest: blt
[525.749451] Dynamic subtest blt: SUCCESS (0.074s)
[525.760948] Starting dynamic subtest: vebox
[525.818600] Dynamic subtest vebox: SUCCESS (0.067s)
[525.821337] Subtest legacy-engines-cleanup: SUCCESS (0.394s)
[525.924883] [082/131] (496s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[526.074638] Starting subtest: cursor-tearing-framebuffer-change
[526.076608] Starting dynamic subtest: pipe-A-eDP-1
[526.639081] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[526.647671] Starting dynamic subtest: pipe-D-eDP-1
[527.861160] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.219s)
[527.863371] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.784s)
[528.718092] [083/131] (493s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[528.837838] Starting subtest: 2x-cursor-vs-flip-atomic
[528.842186] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[529.014239] [084/131] (493s left) kms_cursor_crc (cursor-random-32x10)
[529.168924] Starting subtest: cursor-random-32x10
[529.215108] Subtest cursor-random-32x10: SKIP (0.040s)
[529.517031] [085/131] (493s left) kms_psr (fbc-psr-primary-mmap-gtt)
[529.611190] Starting subtest: fbc-psr-primary-mmap-gtt
[529.613913] Starting dynamic subtest: eDP-1
[529.618599] Dynamic subtest eDP-1: SKIP (0.000s)
[529.623265] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[529.709004] [086/131] (492s left) kms_big_fb (linear-8bpp-rotate-0)
[529.812066] Starting subtest: linear-8bpp-rotate-0
[531.058319] Subtest linear-8bpp-rotate-0: SUCCESS (1.247s)
[531.231147] [087/131] (491s left) gem_create (create-ext-cpu-access-sanity-check)
[531.400007] Starting subtest: create-ext-cpu-access-sanity-check
[531.405459] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[531.501866] [088/131] (491s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[531.613589] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[535.725953] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.116s)
[536.935567] [089/131] (485s left) kms_pm_rpm (cursor-dpms)
[538.462439] Starting subtest: cursor-dpms
[538.467862] Subtest cursor-dpms: SKIP (0.000s)
[539.248587] [090/131] (483s left) gem_lmem_swapping (verify-random-ccs)
[539.292268] Subtest verify-random-ccs: SKIP (0.000s)
[539.336553] [091/131] (483s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[539.467906] Starting subtest: flip-vs-cursor-toggle
[547.933372] Subtest flip-vs-cursor-toggle: SUCCESS (8.468s)
[548.767870] [092/131] (474s left) gem_lmem_swapping (heavy-verify-multi)
[548.815012] Subtest heavy-verify-multi: SKIP (0.000s)
[548.863910] [093/131] (474s left) i915_pm_freq_api (freq-reset)
[548.943465] Starting subtest: freq-reset
[548.946201] Starting dynamic subtest: gt0
[549.138454] Dynamic subtest gt0: SUCCESS (0.193s)
[549.146844] Starting dynamic subtest: gt1
[549.300763] Dynamic subtest gt1: SUCCESS (0.162s)
[549.303323] Subtest freq-reset: SUCCESS (0.357s)
[549.399115] [094/131] (473s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[549.512354] Starting subtest: y-tiled-64bpp-rotate-90
[549.517244] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[549.648820] [095/131] (473s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[549.751271] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[549.755561] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[549.884585] [096/131] (473s left) kms_dirtyfb (default-dirtyfb-ioctl)
[549.978825] Starting subtest: default-dirtyfb-ioctl
[549.981254] Starting dynamic subtest: A-eDP-1
[551.609148] Dynamic subtest A-eDP-1: SUCCESS (1.628s)
[551.611737] Subtest default-dirtyfb-ioctl: SUCCESS (1.630s)
[552.488636] [097/131] (470s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[552.588151] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[552.590603] Starting dynamic subtest: pipe-A
[552.950843] Dynamic subtest pipe-A: SUCCESS (0.364s)
[552.960091] Starting dynamic subtest: pipe-B
[554.388204] Dynamic subtest pipe-B: SUCCESS (1.437s)
[554.396915] Starting dynamic subtest: pipe-C
[555.801086] Dynamic subtest pipe-C: SUCCESS (1.411s)
[555.810634] Starting dynamic subtest: pipe-D
[557.199252] Dynamic subtest pipe-D: SUCCESS (1.398s)
[557.202147] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.614s)
[558.403263] [098/131] (464s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[558.507128] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[558.509623] Starting dynamic subtest: pipe-A-default-mode
[558.823487] Dynamic subtest pipe-A-default-mode: SKIP (0.315s)
[558.829158] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.317s)
[559.628799] [099/131] (463s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[559.749593] Starting subtest: 2x-cursor-vs-flip-legacy
[559.754593] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[559.918704] [100/131] (463s left) gem_readwrite (write-bad-handle)
[559.979924] Subtest write-bad-handle: SKIP (0.000s)
[560.039579] [101/131] (463s left) gem_reg_read (timestamp-monotonic)
[560.104906] Starting subtest: timestamp-monotonic
[564.797830] Subtest timestamp-monotonic: SUCCESS (4.694s)
[564.903312] [102/131] (458s left) kms_psr (fbc-psr2-cursor-plane-move)
[565.024693] Starting subtest: fbc-psr2-cursor-plane-move
[565.027278] Starting dynamic subtest: eDP-1
[565.032279] Dynamic subtest eDP-1: SKIP (0.000s)
[565.037196] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[565.126631] [103/131] (458s left) kms_plane_lowres (tiling-x)
[565.218054] Starting subtest: tiling-x
[565.220283] Starting dynamic subtest: pipe-A-eDP-1
[565.225077] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[565.507685] Starting dynamic subtest: pipe-B-eDP-1
[565.513323] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[565.524147] Starting dynamic subtest: pipe-C-eDP-1
[565.529245] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[565.538808] Starting dynamic subtest: pipe-D-eDP-1
[565.544242] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[565.549376] Subtest tiling-x: SKIP (0.289s)
[566.367787] [104/131] (457s left) kms_force_connector_basic (force-edid)
[566.453198] Starting subtest: force-edid
[566.819453] Subtest force-edid: SUCCESS (0.369s)
[566.983022] [105/131] (456s left) kms_getfb (getfb-handle-zero)
[567.072453] Starting subtest: getfb-handle-zero
[567.075283] Subtest getfb-handle-zero: SUCCESS (0.000s)
[567.192879] [106/131] (456s left) perf (missing-sample-flags)
[567.327058] Starting subtest: missing-sample-flags
[567.328950] Subtest missing-sample-flags: SUCCESS (0.000s)
[567.366597] [107/131] (456s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[567.462936] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[574.001620] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.541s)
[574.181656] [108/131] (449s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[574.292921] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[574.297436] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[574.431988] [109/131] (449s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[574.542251] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[574.547368] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[574.704937] [110/131] (448s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[574.799693] Starting subtest: 4-tiled-8bpp-rotate-180
[576.057874] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.258s)
[576.227543] [111/131] (447s left) gem_exec_fence (syncobj-timeline-repeat)
[576.778341] Starting subtest: syncobj-timeline-repeat
[576.997392] Subtest syncobj-timeline-repeat: SUCCESS (0.219s)
[578.436098] [112/131] (445s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[578.540468] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[585.801907] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.265s)
[585.987849] [113/131] (437s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[586.056370] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[586.059070] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[586.177382] [114/131] (437s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[586.287106] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[589.964334] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.680s)
[591.197402] [115/131] (432s left) gem_exec_schedule (lateslice)
[591.267257] Starting subtest: lateslice
[591.269931] Starting dynamic subtest: rcs0
[591.281633] Dynamic subtest rcs0: SUCCESS (0.026s)
[591.291088] Starting dynamic subtest: bcs0
[591.300157] Dynamic subtest bcs0: SUCCESS (0.017s)
[591.311465] Starting dynamic subtest: vcs0
[591.318286] Dynamic subtest vcs0: SUCCESS (0.018s)
[591.326955] Starting dynamic subtest: vcs1
[591.337596] Dynamic subtest vcs1: SUCCESS (0.018s)
[591.347528] Starting dynamic subtest: vecs0
[591.356386] Dynamic subtest vecs0: SUCCESS (0.018s)
[591.365098] Starting dynamic subtest: ccs0
[591.373454] Dynamic subtest ccs0: SUCCESS (0.016s)
[591.376228] Subtest lateslice: SUCCESS (0.118s)
[593.407104] [116/131] (430s left) kms_vblank (query-idle-hang)
[593.513325] Starting subtest: query-idle-hang
[593.516295] Starting dynamic subtest: pipe-A-eDP-1
[621.069439] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.555s)
[621.086479] Starting dynamic subtest: pipe-D-eDP-1
[636.044132] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.970s)
[636.047150] Subtest query-idle-hang: SUCCESS (42.529s)
[636.888236] [117/131] (387s left) syncobj_wait (reset-multiple-signaled)
[636.941003] Starting subtest: reset-multiple-signaled
[636.943800] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[637.063197] [118/131] (386s left) kms_flip_event_leak (basic)
[637.163234] Starting subtest: basic
[637.165724] Starting dynamic subtest: pipe-A-eDP-1
[637.589165] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s)
[637.598096] Starting dynamic subtest: pipe-B-eDP-1
[638.754171] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.164s)
[638.764204] Starting dynamic subtest: pipe-C-eDP-1
[639.830347] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.075s)
[639.840759] Starting dynamic subtest: pipe-D-eDP-1
[640.933349] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.101s)
[640.936312] Subtest basic: SUCCESS (3.772s)
[641.787754] [119/131] (382s left) gem_pwrite_snooped
[641.931533] [120/131] (382s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[641.994158] Starting subtest: yf-tiled-ccs-to-y-tiled
[641.999245] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[642.215966] [121/131] (381s left) gem_ctx_shared (q-independent)
[642.294017] Starting subtest: Q-independent
[642.296760] Starting dynamic subtest: rcs0
[642.364816] Dynamic subtest rcs0: SUCCESS (0.070s)
[642.375448] Starting dynamic subtest: vcs0
[642.406240] Dynamic subtest vcs0: SUCCESS (0.040s)
[642.415381] Starting dynamic subtest: vcs1
[642.441906] Dynamic subtest vcs1: SUCCESS (0.035s)
[642.450948] Starting dynamic subtest: vecs0
[642.478585] Dynamic subtest vecs0: SUCCESS (0.036s)
[642.487877] Starting dynamic subtest: ccs0
[642.520174] Dynamic subtest ccs0: SUCCESS (0.040s)
[642.522949] Subtest Q-independent: SUCCESS (0.227s)
[644.432067] [122/131] (379s left) prime_mmap (test_userptr)
[644.491753] Starting subtest: test_userptr
[644.494231] Starting dynamic subtest: test_userptr-smem
[644.496741] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[644.499164] Subtest test_userptr: SUCCESS (0.001s)
[644.625478] [123/131] (379s left) kms_addfb_basic (bad-pitch-65536)
[644.686336] Starting subtest: bad-pitch-65536
[644.688845] Subtest bad-pitch-65536: SUCCESS (0.000s)
[644.842389] [124/131] (379s left) prime_self_import (basic-with_fd_dup)
[644.879900] Starting subtest: basic-with_fd_dup
[644.896499] Subtest basic-with_fd_dup: SUCCESS (0.021s)
[645.026253] [125/131] (379s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[645.114974] Starting subtest: primary-y-tiled-reflect-x-0
[645.174265] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[645.298904] [126/131] (379s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[645.392006] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[645.393977] Starting dynamic subtest: pipe-A-eDP-1
[645.414068] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[645.423775] Starting dynamic subtest: pipe-B-eDP-1
[645.443128] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[645.451166] Starting dynamic subtest: pipe-C-eDP-1
[645.472718] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[645.480672] Starting dynamic subtest: pipe-D-eDP-1
[645.502717] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[645.507238] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[647.688783] [127/131] (376s left) kms_addfb_basic (unused-modifier)
[647.749909] Starting subtest: unused-modifier
[647.752148] Subtest unused-modifier: SUCCESS (0.000s)
[647.916892] [128/131] (376s left) kms_vblank (wait-idle)
[648.015525] Starting subtest: wait-idle
[648.018306] Starting dynamic subtest: pipe-A-eDP-1
[649.787066] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.772s)
[649.802522] Starting dynamic subtest: pipe-D-eDP-1
[652.275342] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.486s)
[652.278244] Subtest wait-idle: SUCCESS (4.262s)
[653.102720] [129/131] (371s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[653.232936] Starting subtest: cursorA-vs-flipA-toggle
[664.361674] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.130s)
[665.185315] [130/131] (359s left) gen9_exec_parse (bb-start-far)
[665.254227] Subtest bb-start-far: SKIP (0.000s)
[665.336288] [131/131] (359s left) kms_addfb_basic (basic)
[665.387627] Starting subtest: basic
[665.390290] Subtest basic: SUCCESS (0.000s)
[665.589592] 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.