[59.540547] Initializing watchdogs
[59.540683]   /dev/watchdog0
[59.556408] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.560810] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.563164] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.566574] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[59.644241] Starting subtest: invalid-bad-pad
[59.646697] Subtest invalid-bad-pad: SUCCESS (0.000s)
[59.747198] [002/131] (960s left) tools_test (tools_test)
[59.801935] Starting subtest: tools_test
[59.852051] Subtest tools_test: SUCCESS (0.066s)
[59.936113] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[59.993305] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[60.051396] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[60.135675] Starting subtest: sync-unmap-cycles
[65.532703] Subtest sync-unmap-cycles: SUCCESS (5.380s)
[65.709379] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[65.830098] Starting subtest: stress-xrgb8888-ytiled
[65.834024] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[65.917353] [006/131] (954s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[66.008098] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[66.010110] Starting dynamic subtest: pipe-A-eDP-1
[82.225964] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.940s)
[82.234040] Starting dynamic subtest: pipe-B-eDP-1
[99.170568] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.414s)
[99.179750] Starting dynamic subtest: pipe-C-eDP-1
[116.146191] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.362s)
[116.156096] Starting dynamic subtest: pipe-D-eDP-1
[133.141159] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.354s)
[133.143502] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (13.074s)
[134.441791] [007/131] (885s left) api_intel_allocator (gem-pool)
[134.514423] Starting subtest: gem-pool
[134.520928] Subtest gem-pool: SUCCESS (0.008s)
[134.680093] [008/131] (885s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[134.785191] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[141.398429] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.502s)
[141.557345] [009/131] (878s left) kms_atomic_interruptible (universal-setplane-primary)
[141.658961] Starting subtest: universal-setplane-primary
[141.661298] Starting dynamic subtest: pipe-A-eDP-1
[149.119434] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.407s)
[149.121412] Subtest universal-setplane-primary: SUCCESS (7.408s)
[150.005037] [010/131] (870s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[150.114206] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[154.390748] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.267s)
[155.616668] [011/131] (864s left) gem_eio (in-flight-contexts-1us)
[155.837897] Starting subtest: in-flight-contexts-1us
[167.803385] Subtest in-flight-contexts-1us: SUCCESS (11.953s)
[167.997020] [012/131] (852s left) gem_exec_balancer (semaphore)
[168.066913] Starting subtest: semaphore
[169.796297] Subtest semaphore: SUCCESS (1.728s)
[170.130085] [013/131] (850s left) kms_chamelium_hpd (hdmi-hpd)
[170.516751] Subtest hdmi-hpd: SKIP (0.000s)
[171.292542] [014/131] (849s left) kms_flip (wf_vblank-ts-check)
[171.389396] Starting subtest: wf_vblank-ts-check
[171.391633] Starting dynamic subtest: A-eDP1
[180.277324] Dynamic subtest A-eDP1: SUCCESS (8.890s)
[180.285612] Starting dynamic subtest: B-eDP1
[189.204624] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[189.215866] Starting dynamic subtest: C-eDP1
[198.121534] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[198.131064] Starting dynamic subtest: D-eDP1
[207.061838] Dynamic subtest D-eDP1: SUCCESS (8.937s)
[207.067337] Subtest wf_vblank-ts-check: SUCCESS (35.673s)
[208.307668] [015/131] (812s left) gem_exec_reloc (basic-gtt)
[208.378505] Subtest basic-gtt: SKIP (0.000s)
[208.446440] [016/131] (812s left) gem_exec_schedule (reorder-wide)
[208.643283] Subtest reorder-wide: SKIP (0.000s)
[208.843094] [017/131] (811s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[208.957210] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[208.959438] Starting dynamic subtest: pipe-A-eDP-1
[208.981721] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[208.991535] Starting dynamic subtest: pipe-B-eDP-1
[209.013064] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[209.021455] Starting dynamic subtest: pipe-C-eDP-1
[209.042776] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[209.050704] Starting dynamic subtest: pipe-D-eDP-1
[209.072431] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[209.076451] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[211.267239] [018/131] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[211.371796] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[211.376292] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[211.496575] [019/131] (809s left) perf (polling)
[211.627880] Starting subtest: polling
[211.630070] Starting dynamic subtest: 0-rcs0
[221.660168] Dynamic subtest 0-rcs0: SUCCESS (10.027s)
[221.668957] Starting dynamic subtest: 1-vcs0
[231.680699] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[231.683162] Subtest polling: SUCCESS (20.048s)
[231.729245] [020/131] (789s left) gem_userptr_blits (probe)
[231.803310] Starting subtest: probe
[231.877293] Subtest probe: SUCCESS (0.076s)
[232.030880] [021/131] (788s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[232.143713] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[232.147902] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[232.255478] [022/131] (788s left) gem_mmap_offset (pf-nonblock)
[232.318984] Starting subtest: pf-nonblock
[232.328421] Subtest pf-nonblock: SUCCESS (0.010s)
[232.504652] [023/131] (788s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[232.603078] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[232.606046] Starting dynamic subtest: pipe-A-eDP-1
[232.631127] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[232.644820] Starting dynamic subtest: pipe-B-eDP-1
[232.668563] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.678064] Starting dynamic subtest: pipe-C-eDP-1
[232.700023] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.708054] Starting dynamic subtest: pipe-D-eDP-1
[232.729599] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.733300] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[234.844390] [024/131] (786s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[234.944841] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[234.949240] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[235.087458] [025/131] (785s left) core_getstats (basic)
[235.145877] Starting subtest: basic
[235.148215] Subtest basic: SUCCESS (0.000s)
[235.279946] [026/131] (785s left) core_getclient (basic)
[235.328040] Starting subtest: basic
[235.329877] Subtest basic: SUCCESS (0.000s)
[235.457936] [027/131] (785s left) syncobj_timeline (multi-wait-all-available-submitted)
[235.509859] Starting subtest: multi-wait-all-available-submitted
[235.512098] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[235.645650] [028/131] (785s left) gem_exec_reloc (basic-write-wc)
[235.709069] Subtest basic-write-wc: SKIP (0.000s)
[235.773944] [029/131] (785s left) kms_invalid_mode (clock-too-high)
[235.868150] Starting subtest: clock-too-high
[235.870153] Starting dynamic subtest: pipe-A-eDP-1
[235.873694] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[235.882571] Starting dynamic subtest: pipe-B-eDP-1
[235.886217] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[235.894069] Starting dynamic subtest: pipe-C-eDP-1
[235.897535] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[235.904941] Starting dynamic subtest: pipe-D-eDP-1
[235.908443] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[235.911924] Subtest clock-too-high: SKIP (0.003s)
[235.962162] [030/131] (785s left) gem_mmap_offset (bad-object)
[236.024795] Starting subtest: bad-object
[236.026724] Subtest bad-object: SUCCESS (0.001s)
[236.142485] [031/131] (785s left) syncobj_timeline (wait-all-delayed-signal)
[236.209830] Starting subtest: wait-all-delayed-signal
[236.313431] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[236.410900] [032/131] (784s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[236.527206] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[237.218243] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[237.435072] [033/131] (783s left) gem_exec_suspend (basic-s3)
[237.506549] Starting subtest: basic-S3
[237.508988] Starting dynamic subtest: smem
[256.938474] Dynamic subtest smem: SUCCESS (6.209s)
[256.941607] Subtest basic-S3: SUCCESS (6.211s)
[257.151229] [034/131] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[257.255718] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[257.260365] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[257.373000] [035/131] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[257.488538] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[257.492714] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[257.616220] [036/131] (763s left) kms_chamelium_frames (hdmi-crc-multiple)
[258.026440] Subtest hdmi-crc-multiple: SKIP (0.000s)
[258.840179] [037/131] (762s left) gem_exec_fence (syncobj-import)
[259.313162] Starting subtest: syncobj-import
[259.318377] Subtest syncobj-import: SUCCESS (0.005s)
[260.994547] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[260.997989] [038/131] (760s left) kms_legacy_colorkey (basic)
[261.098185] Starting subtest: basic
[261.100127] Starting dynamic subtest: pipe-A
[261.141891] Dynamic subtest pipe-A: SUCCESS (0.045s)
[261.153787] Starting dynamic subtest: pipe-B
[261.156100] Dynamic subtest pipe-B: SUCCESS (0.001s)
[261.164400] Starting dynamic subtest: pipe-C
[261.166738] Dynamic subtest pipe-C: SUCCESS (0.000s)
[261.174883] Starting dynamic subtest: pipe-D
[261.176823] Dynamic subtest pipe-D: SUCCESS (0.000s)
[261.178832] Subtest basic: SUCCESS (0.050s)
[261.238024] [039/131] (760s left) gem_softpin (allocator-nopin-reserve)
[261.301357] Starting subtest: allocator-nopin-reserve
[261.394947] Subtest allocator-nopin-reserve: SUCCESS (0.091s)
[261.571212] [040/131] (760s left) perf_pmu (enable-race)
[261.616543] Starting subtest: enable-race
[261.619045] Starting dynamic subtest: rcs0
[274.390908] Dynamic subtest rcs0: SUCCESS (12.679s)
[274.399492] Starting dynamic subtest: bcs0
[287.134092] Dynamic subtest bcs0: SUCCESS (12.720s)
[287.144068] Starting dynamic subtest: vcs0
[302.888220] Dynamic subtest vcs0: SUCCESS (15.748s)
[302.900171] Starting dynamic subtest: vcs1
[318.953686] Dynamic subtest vcs1: SUCCESS (16.058s)
[318.963547] Starting dynamic subtest: vecs0
[334.952276] Dynamic subtest vecs0: SUCCESS (15.990s)
[334.964462] Starting dynamic subtest: ccs0
[347.694881] Dynamic subtest ccs0: SUCCESS (12.737s)
[347.697287] Subtest enable-race: SUCCESS (85.942s)
[347.837295] [041/131] (673s left) syncobj_timeline (signal-point-0)
[347.893046] Starting subtest: signal-point-0
[347.895366] Subtest signal-point-0: SUCCESS (0.000s)
[348.020098] [042/131] (673s left) gem_tiled_wb
[348.136012] [043/131] (673s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[348.224542] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[348.226776] Starting dynamic subtest: pipe-A-eDP-1
[348.250531] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[348.262131] Starting dynamic subtest: pipe-B-eDP-1
[348.285471] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[348.297389] Starting dynamic subtest: pipe-C-eDP-1
[348.321803] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[348.331443] Starting dynamic subtest: pipe-D-eDP-1
[348.356697] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[348.361182] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[350.515915] [044/131] (671s left) gem_ctx_param (set-priority-invalid-size)
[350.578739] Starting subtest: set-priority-invalid-size
[350.581240] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[350.684832] [045/131] (671s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[350.779882] Starting subtest: plane-ctm3x4-lut1d
[350.792481] Starting dynamic subtest: pipe-A-eDP-1
[351.507679] Dynamic subtest pipe-A-eDP-1: FAIL (0.336s)
[352.180107] Starting dynamic subtest: pipe-B-eDP-1
[353.012519] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[353.605475] Starting dynamic subtest: pipe-C-eDP-1
[354.479257] Dynamic subtest pipe-C-eDP-1: FAIL (0.280s)
[354.939029] Starting dynamic subtest: pipe-D-eDP-1
[355.794479] Dynamic subtest pipe-D-eDP-1: FAIL (0.269s)
[355.796423] Subtest plane-ctm3x4-lut1d: FAIL (4.698s)
[356.344627] [046/131] (665s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[356.470110] Starting subtest: 2x-long-cursor-vs-flip-atomic
[356.474443] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[356.637733] [047/131] (665s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[356.742175] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[356.746534] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[356.887647] [048/131] (665s left) kms_feature_discovery (display-1x)
[357.001852] Starting subtest: display-1x
[357.004166] Subtest display-1x: SUCCESS (0.000s)
[357.097946] [049/131] (664s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[357.206932] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[357.211581] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[357.338421] [050/131] (664s left) i915_drm_fdinfo (most-busy-idle-check-all)
[357.393524] Starting subtest: most-busy-idle-check-all
[357.395507] Starting dynamic subtest: rcs0
[357.401776] Dynamic subtest rcs0: SKIP (0.006s)
[357.414383] Starting dynamic subtest: bcs0
[357.417747] Dynamic subtest bcs0: SKIP (0.001s)
[357.426034] Starting dynamic subtest: vcs0
[357.429407] Dynamic subtest vcs0: SKIP (0.001s)
[357.437310] Starting dynamic subtest: vcs1
[357.440569] Dynamic subtest vcs1: SKIP (0.000s)
[357.448591] Starting dynamic subtest: vecs0
[357.451801] Dynamic subtest vecs0: SKIP (0.000s)
[357.459629] Starting dynamic subtest: ccs0
[357.463102] Dynamic subtest ccs0: SKIP (0.000s)
[357.466651] Subtest most-busy-idle-check-all: SKIP (0.012s)
[357.503349] [051/131] (664s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[357.605101] Starting subtest: x-tiled-32bpp-rotate-270
[357.625429] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[357.786364] [052/131] (664s left) gem_exec_schedule (u-submit-early-slice)
[357.869542] Starting subtest: u-submit-early-slice
[357.871348] Starting dynamic subtest: rcs0
[357.909996] Dynamic subtest rcs0: SUCCESS (0.044s)
[357.920647] Starting dynamic subtest: bcs0
[357.949234] Dynamic subtest bcs0: SUCCESS (0.039s)
[357.957648] Starting dynamic subtest: vcs0
[357.994884] Dynamic subtest vcs0: SUCCESS (0.045s)
[358.003999] Starting dynamic subtest: vcs1
[358.032635] Dynamic subtest vcs1: SUCCESS (0.037s)
[358.042390] Starting dynamic subtest: vecs0
[358.094765] Dynamic subtest vecs0: SUCCESS (0.061s)
[358.105215] Starting dynamic subtest: ccs0
[358.136503] Dynamic subtest ccs0: SUCCESS (0.040s)
[358.138673] Subtest u-submit-early-slice: SUCCESS (0.271s)
[360.044926] [053/131] (662s left) gem_pxp (regular-baseline-src-copy-readible)
[360.177157] Starting subtest: regular-baseline-src-copy-readible
[360.234569] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[360.421386] [054/131] (661s left) gem_exec_balancer (full-late-pulse)
[360.489623] Starting subtest: full-late-pulse
[364.870520] Subtest full-late-pulse: SUCCESS (4.382s)
[365.170987] [055/131] (657s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[365.273823] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[365.278426] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[365.417552] [056/131] (656s left) fbdev (read)
[365.456237] Starting subtest: read
[365.983158] Subtest read: SUCCESS (0.528s)
[366.068793] [057/131] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[366.181428] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[366.185545] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[366.310180] [058/131] (656s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[366.417796] Starting subtest: multiplane-rotation-cropping-top
[383.807206] Subtest multiplane-rotation-cropping-top: SUCCESS (17.393s)
[383.974974] [059/131] (638s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[384.086268] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[391.049740] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.965s)
[391.223197] [060/131] (631s left) i915_selftest (mock)
[394.799299] Starting subtest: mock
[394.801742] Starting dynamic subtest: sanitycheck
[395.521000] Dynamic subtest sanitycheck: SUCCESS (0.722s)
[395.530748] Starting dynamic subtest: shmem
[396.288195] Dynamic subtest shmem: SUCCESS (0.765s)
[396.298104] Starting dynamic subtest: fence
[404.131862] Dynamic subtest fence: SUCCESS (7.839s)
[404.141059] Starting dynamic subtest: scatterlist
[405.874119] Dynamic subtest scatterlist: SUCCESS (1.739s)
[405.887409] Starting dynamic subtest: syncmap
[409.174144] Dynamic subtest syncmap: SUCCESS (3.296s)
[409.184145] Starting dynamic subtest: uncore
[409.932103] Dynamic subtest uncore: SUCCESS (0.756s)
[409.941400] Starting dynamic subtest: ring
[410.708998] Dynamic subtest ring: SUCCESS (0.775s)
[410.718483] Starting dynamic subtest: engine
[411.473950] Dynamic subtest engine: SUCCESS (0.763s)
[411.483619] Starting dynamic subtest: timelines
[415.497671] Dynamic subtest timelines: SUCCESS (4.020s)
[415.507207] Starting dynamic subtest: requests
[418.831349] Dynamic subtest requests: SUCCESS (3.330s)
[418.840921] Starting dynamic subtest: objects
[419.717816] Dynamic subtest objects: SUCCESS (0.884s)
[419.727501] Starting dynamic subtest: phys
[420.625532] Dynamic subtest phys: SUCCESS (0.906s)
[420.635192] Starting dynamic subtest: dmabuf
[421.482279] Dynamic subtest dmabuf: SUCCESS (0.855s)
[421.492082] Starting dynamic subtest: vma
[427.003184] Dynamic subtest vma: SUCCESS (5.516s)
[427.012673] Starting dynamic subtest: evict
[428.474600] Dynamic subtest evict: SUCCESS (1.469s)
[428.484322] Starting dynamic subtest: gtt
[431.767045] Dynamic subtest gtt: SUCCESS (3.289s)
[431.776684] Starting dynamic subtest: hugepages
[432.792667] Dynamic subtest hugepages: SUCCESS (1.023s)
[432.803059] Starting dynamic subtest: memory_region
[435.419119] Dynamic subtest memory_region: SUCCESS (2.625s)
[435.421830] Subtest mock: SUCCESS (40.612s)
[435.454031] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[435.454755] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[435.458104] [061/131] (587s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[441.920945] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[441.923311] Starting dynamic subtest: pipe-A-eDP-1
[442.717327] Dynamic subtest pipe-A-eDP-1: SKIP (0.794s)
[442.726755] Starting dynamic subtest: pipe-B-eDP-1
[443.844711] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[443.848909] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.924s)
[445.076538] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[445.077912] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[445.081614] [062/131] (577s left) gem_render_copy_redux (normal)
[445.156453] Starting subtest: normal
[445.415505] Subtest normal: SUCCESS (0.258s)
[445.576310] [063/131] (576s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[445.652396] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[445.742283] [064/131] (576s left) gem_ctx_param (invalid-set-no-zeromap)
[445.804898] Starting subtest: invalid-set-no-zeromap
[445.807674] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[445.906431] [065/131] (576s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[446.008972] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[455.347273] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.336s)
[455.497525] [066/131] (567s left) i915_pm_rps (reset)
[455.567479] Starting subtest: reset
[463.984276] Subtest reset: SUCCESS (8.411s)
[464.138145] [067/131] (558s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[464.238583] Starting subtest: async-flip-with-page-flip-events-linear
[464.616043] Starting dynamic subtest: pipe-A-eDP-1
[467.372210] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.755s)
[467.735450] Starting dynamic subtest: pipe-B-eDP-1
[470.498950] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.769s)
[470.869866] Starting dynamic subtest: pipe-C-eDP-1
[473.627154] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s)
[473.986578] Starting dynamic subtest: pipe-D-eDP-1
[476.752648] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[476.755068] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.511s)
[477.961225] [068/131] (544s left) perf_pmu (module-unload)
[478.063668] Starting subtest: module-unload
[484.914498] Subtest module-unload: FAIL (6.740s)
[484.945912] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[484.946633] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[484.949241] [069/131] (537s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[486.670270] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[486.674465] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[486.781354] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[486.782631] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[486.786556] [070/131] (536s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[486.851829] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[486.957239] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[487.059049] [071/131] (535s left) kms_cursor_crc (cursor-random-256x85)
[487.298180] Starting subtest: cursor-random-256x85
[487.350290] Subtest cursor-random-256x85: SKIP (0.046s)
[487.561231] [072/131] (535s left) kms_psr (psr-sprite-plane-move)
[487.649603] Starting subtest: psr-sprite-plane-move
[487.651871] Starting dynamic subtest: eDP-1
[489.390536] Dynamic subtest eDP-1: SUCCESS (1.740s)
[489.392426] Subtest psr-sprite-plane-move: SUCCESS (1.741s)
[490.243445] [073/131] (532s left) kms_psr (fbc-pr-sprite-plane-onoff)
[490.339104] Starting subtest: fbc-pr-sprite-plane-onoff
[490.343410] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[490.435067] [074/131] (532s left) kms_pm_rpm (pm-tiling)
[492.085132] Starting subtest: pm-tiling
[492.089749] Subtest pm-tiling: SKIP (0.000s)
[492.781923] [075/131] (530s left) gem_userptr_blits (invalid-null-pointer)
[492.858561] Starting subtest: invalid-null-pointer
[492.860882] Subtest invalid-null-pointer: SUCCESS (0.001s)
[493.029227] [076/131] (530s left) kms_content_protection (lic-type-1)
[493.178826] Starting subtest: lic-type-1
[493.183275] Subtest lic-type-1: SKIP (0.000s)
[493.358688] [077/131] (529s left) kms_atomic (plane-immutable-zpos)
[493.455264] Starting subtest: plane-immutable-zpos
[493.457597] Starting dynamic subtest: pipe-A-eDP-1
[494.087336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s)
[494.089673] Subtest plane-immutable-zpos: SUCCESS (0.635s)
[494.907550] [078/131] (528s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[495.028313] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[495.032783] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[495.194558] [079/131] (528s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[495.285364] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[495.287731] Starting dynamic subtest: pipe-A
[496.331804] Dynamic subtest pipe-A: SUCCESS (1.050s)
[496.340645] Starting dynamic subtest: pipe-B
[498.485376] Dynamic subtest pipe-B: SUCCESS (2.153s)
[498.496206] Starting dynamic subtest: pipe-C
[499.682583] Dynamic subtest pipe-C: SUCCESS (1.196s)
[499.691688] Starting dynamic subtest: pipe-D
[500.917687] Dynamic subtest pipe-D: SUCCESS (1.235s)
[500.919883] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.637s)
[502.128284] [080/131] (521s left) kms_psr (pr-sprite-mmap-cpu)
[502.230066] Starting subtest: pr-sprite-mmap-cpu
[502.234736] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[502.329104] [081/131] (520s left) gem_ctx_persistence (legacy-engines-cleanup)
[502.395743] Starting subtest: legacy-engines-cleanup
[502.398146] Starting dynamic subtest: render
[502.449705] Dynamic subtest render: SUCCESS (0.053s)
[502.460148] Starting dynamic subtest: bsd1
[502.539721] Dynamic subtest bsd1: SUCCESS (0.088s)
[502.550404] Starting dynamic subtest: bsd2
[502.599610] Dynamic subtest bsd2: SUCCESS (0.057s)
[502.613660] Starting dynamic subtest: blt
[502.633122] Dynamic subtest blt: SUCCESS (0.031s)
[502.640895] Starting dynamic subtest: vebox
[502.705396] Dynamic subtest vebox: SUCCESS (0.070s)
[502.707794] Subtest legacy-engines-cleanup: SUCCESS (0.311s)
[502.866768] [082/131] (520s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[502.984915] Starting subtest: cursor-tearing-framebuffer-change
[502.987121] Starting dynamic subtest: pipe-A-eDP-1
[503.554383] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[503.563381] Starting dynamic subtest: pipe-D-eDP-1
[504.743243] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.186s)
[504.745443] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.755s)
[505.595774] [083/131] (517s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[505.710957] Starting subtest: 2x-cursor-vs-flip-atomic
[505.715311] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[505.879740] [084/131] (517s left) kms_cursor_crc (cursor-random-32x10)
[506.044484] Starting subtest: cursor-random-32x10
[506.088415] Subtest cursor-random-32x10: SKIP (0.041s)
[506.378262] [085/131] (517s left) kms_psr (fbc-psr-primary-mmap-gtt)
[506.476952] Starting subtest: fbc-psr-primary-mmap-gtt
[506.479152] Starting dynamic subtest: eDP-1
[506.483167] Dynamic subtest eDP-1: SKIP (0.000s)
[506.487233] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[506.576968] [086/131] (516s left) kms_big_fb (linear-8bpp-rotate-0)
[506.672392] Starting subtest: linear-8bpp-rotate-0
[507.931433] Subtest linear-8bpp-rotate-0: SUCCESS (1.258s)
[508.088570] [087/131] (515s left) gem_create (create-ext-cpu-access-sanity-check)
[508.256617] Starting subtest: create-ext-cpu-access-sanity-check
[508.261468] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[508.355435] [088/131] (515s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[508.468790] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[512.671874] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.206s)
[513.895650] [089/131] (509s left) kms_pm_rpm (cursor-dpms)
[516.064598] Starting subtest: cursor-dpms
[516.069721] Subtest cursor-dpms: SKIP (0.000s)
[516.466175] [090/131] (507s left) gem_lmem_swapping (verify-random-ccs)
[516.509478] Subtest verify-random-ccs: SKIP (0.000s)
[516.551363] [091/131] (507s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[516.667359] Starting subtest: flip-vs-cursor-toggle
[525.192151] Subtest flip-vs-cursor-toggle: SUCCESS (8.526s)
[526.074935] [092/131] (497s left) gem_lmem_swapping (heavy-verify-multi)
[526.120745] Subtest heavy-verify-multi: SKIP (0.000s)
[526.167170] [093/131] (497s left) i915_pm_freq_api (freq-reset)
[526.234884] Starting subtest: freq-reset
[526.237083] Starting dynamic subtest: gt0
[526.429422] Dynamic subtest gt0: SUCCESS (0.194s)
[526.439169] Starting dynamic subtest: gt1
[526.592907] Dynamic subtest gt1: SUCCESS (0.161s)
[526.595808] Subtest freq-reset: SUCCESS (0.357s)
[526.694487] [094/131] (497s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[526.802167] Starting subtest: y-tiled-64bpp-rotate-90
[526.806539] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[526.933959] [095/131] (496s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[527.043942] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[527.048212] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[527.169534] [096/131] (496s left) kms_dirtyfb (default-dirtyfb-ioctl)
[527.275496] Starting subtest: default-dirtyfb-ioctl
[527.277692] Starting dynamic subtest: A-eDP-1
[528.905310] Dynamic subtest A-eDP-1: SUCCESS (1.629s)
[528.907574] Subtest default-dirtyfb-ioctl: SUCCESS (1.630s)
[529.811895] [097/131] (494s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[529.910938] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[529.913244] Starting dynamic subtest: pipe-A
[530.295228] Dynamic subtest pipe-A: SUCCESS (0.386s)
[530.304550] Starting dynamic subtest: pipe-B
[531.673084] Dynamic subtest pipe-B: SUCCESS (1.377s)
[531.682913] Starting dynamic subtest: pipe-C
[533.089665] Dynamic subtest pipe-C: SUCCESS (1.416s)
[533.098850] Starting dynamic subtest: pipe-D
[534.526400] Dynamic subtest pipe-D: SUCCESS (1.436s)
[534.528647] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.618s)
[535.719797] [098/131] (488s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[535.822095] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[535.824219] Starting dynamic subtest: pipe-A-default-mode
[536.152500] Dynamic subtest pipe-A-default-mode: SKIP (0.330s)
[536.156969] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.331s)
[536.954950] [099/131] (487s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[537.082417] Starting subtest: 2x-cursor-vs-flip-legacy
[537.087105] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[537.266014] [100/131] (486s left) gem_readwrite (write-bad-handle)
[537.326920] Subtest write-bad-handle: SKIP (0.000s)
[537.403503] [101/131] (486s left) gem_reg_read (timestamp-monotonic)
[537.472865] Starting subtest: timestamp-monotonic
[542.410872] Subtest timestamp-monotonic: SUCCESS (4.939s)
[542.522654] [102/131] (481s left) kms_psr (fbc-psr2-cursor-plane-move)
[542.622915] Starting subtest: fbc-psr2-cursor-plane-move
[542.625144] Starting dynamic subtest: eDP-1
[542.629091] Dynamic subtest eDP-1: SKIP (0.000s)
[542.633120] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[542.721790] [103/131] (481s left) kms_plane_lowres (tiling-x)
[542.822882] Starting subtest: tiling-x
[542.825139] Starting dynamic subtest: pipe-A-eDP-1
[542.829670] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[543.118412] Starting dynamic subtest: pipe-B-eDP-1
[543.122786] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[543.131598] Starting dynamic subtest: pipe-C-eDP-1
[543.135975] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[543.144741] Starting dynamic subtest: pipe-D-eDP-1
[543.149196] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[543.153538] Subtest tiling-x: SKIP (0.294s)
[543.975631] [104/131] (480s left) kms_force_connector_basic (force-edid)
[544.055887] Starting subtest: force-edid
[544.443266] Subtest force-edid: SUCCESS (0.389s)
[544.607789] [105/131] (479s left) kms_getfb (getfb-handle-zero)
[544.711025] Starting subtest: getfb-handle-zero
[544.712898] Subtest getfb-handle-zero: SUCCESS (0.000s)
[544.854283] [106/131] (479s left) perf (missing-sample-flags)
[545.006357] Starting subtest: missing-sample-flags
[545.008062] Subtest missing-sample-flags: SUCCESS (0.000s)
[545.050115] [107/131] (479s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[545.151147] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[551.729726] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.580s)
[551.925132] [108/131] (472s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[552.040326] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[552.044482] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[552.171327] [109/131] (472s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[552.286204] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[552.290539] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[552.423772] [110/131] (472s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[552.538436] Starting subtest: 4-tiled-8bpp-rotate-180
[553.761975] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.225s)
[553.934927] [111/131] (470s left) gem_exec_fence (syncobj-timeline-repeat)
[554.485455] Starting subtest: syncobj-timeline-repeat
[554.729601] Subtest syncobj-timeline-repeat: SUCCESS (0.244s)
[556.085809] [112/131] (468s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[556.193517] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[563.351139] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.160s)
[563.511287] [113/131] (461s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[563.562867] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[563.565116] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[563.695112] [114/131] (460s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[563.801396] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[567.433229] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.635s)
[568.608162] [115/131] (456s left) gem_exec_schedule (lateslice)
[568.692499] Starting subtest: lateslice
[568.694584] Starting dynamic subtest: rcs0
[568.704482] Dynamic subtest rcs0: SUCCESS (0.022s)
[568.717150] Starting dynamic subtest: bcs0
[568.722118] Dynamic subtest bcs0: SUCCESS (0.017s)
[568.731188] Starting dynamic subtest: vcs0
[568.741203] Dynamic subtest vcs0: SUCCESS (0.018s)
[568.750042] Starting dynamic subtest: vcs1
[568.759740] Dynamic subtest vcs1: SUCCESS (0.018s)
[568.768730] Starting dynamic subtest: vecs0
[568.776712] Dynamic subtest vecs0: SUCCESS (0.016s)
[568.786808] Starting dynamic subtest: ccs0
[568.795974] Dynamic subtest ccs0: SUCCESS (0.019s)
[568.798288] Subtest lateslice: SUCCESS (0.114s)
[570.086443] [116/131] (454s left) kms_vblank (query-idle-hang)
[570.181078] Starting subtest: query-idle-hang
[570.183348] Starting dynamic subtest: pipe-A-eDP-1
[597.682486] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.497s)
[597.697236] Starting dynamic subtest: pipe-D-eDP-1
[612.720190] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.031s)
[612.722393] Subtest query-idle-hang: SUCCESS (42.533s)
[613.601423] [117/131] (411s left) syncobj_wait (reset-multiple-signaled)
[613.660572] Starting subtest: reset-multiple-signaled
[613.662893] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[613.810768] [118/131] (411s left) kms_flip_event_leak (basic)
[613.908798] Starting subtest: basic
[613.910954] Starting dynamic subtest: pipe-A-eDP-1
[614.328558] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[614.338596] Starting dynamic subtest: pipe-B-eDP-1
[615.461441] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.130s)
[615.470568] Starting dynamic subtest: pipe-C-eDP-1
[616.543928] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.080s)
[616.553604] Starting dynamic subtest: pipe-D-eDP-1
[617.644532] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.100s)
[617.646936] Subtest basic: SUCCESS (3.736s)
[618.495993] [119/131] (406s left) gem_pwrite_snooped
[618.641406] [120/131] (406s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[618.701282] Starting subtest: yf-tiled-ccs-to-y-tiled
[618.705454] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[618.907884] [121/131] (406s left) gem_ctx_shared (q-independent)
[618.971426] Starting subtest: Q-independent
[618.973760] Starting dynamic subtest: rcs0
[619.049673] Dynamic subtest rcs0: SUCCESS (0.077s)
[619.060936] Starting dynamic subtest: vcs0
[619.090734] Dynamic subtest vcs0: SUCCESS (0.041s)
[619.100433] Starting dynamic subtest: vcs1
[619.130819] Dynamic subtest vcs1: SUCCESS (0.039s)
[619.141713] Starting dynamic subtest: vecs0
[619.170076] Dynamic subtest vecs0: SUCCESS (0.038s)
[619.179306] Starting dynamic subtest: ccs0
[619.214944] Dynamic subtest ccs0: SUCCESS (0.044s)
[619.217260] Subtest Q-independent: SUCCESS (0.244s)
[621.107472] [122/131] (403s left) prime_mmap (test_userptr)
[621.164645] Starting subtest: test_userptr
[621.167115] Starting dynamic subtest: test_userptr-smem
[621.169370] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[621.171566] Subtest test_userptr: SUCCESS (0.001s)
[621.308271] [123/131] (403s left) kms_addfb_basic (bad-pitch-65536)
[621.375599] Starting subtest: bad-pitch-65536
[621.377855] Subtest bad-pitch-65536: SUCCESS (0.000s)
[621.528683] [124/131] (403s left) prime_self_import (basic-with_fd_dup)
[621.569265] Starting subtest: basic-with_fd_dup
[621.592113] Subtest basic-with_fd_dup: SUCCESS (0.024s)
[621.729026] [125/131] (403s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[621.835221] Starting subtest: primary-y-tiled-reflect-x-0
[621.893972] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[622.017929] [126/131] (403s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[622.122306] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[622.124186] Starting dynamic subtest: pipe-A-eDP-1
[622.143084] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[622.153797] Starting dynamic subtest: pipe-B-eDP-1
[622.171085] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[622.179597] Starting dynamic subtest: pipe-C-eDP-1
[622.197313] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[622.205891] Starting dynamic subtest: pipe-D-eDP-1
[622.223607] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[622.227093] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[624.412311] [127/131] (400s left) kms_addfb_basic (unused-modifier)
[624.474633] Starting subtest: unused-modifier
[624.477326] Subtest unused-modifier: SUCCESS (0.000s)
[624.639121] [128/131] (400s left) kms_vblank (wait-idle)
[624.740893] Starting subtest: wait-idle
[624.743212] Starting dynamic subtest: pipe-A-eDP-1
[626.531207] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.786s)
[626.545848] Starting dynamic subtest: pipe-D-eDP-1
[628.998916] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.461s)
[629.001314] Subtest wait-idle: SUCCESS (4.257s)
[629.897857] [129/131] (395s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[630.026495] Starting subtest: cursorA-vs-flipA-toggle
[641.165768] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.136s)
[642.009500] [130/131] (383s left) gen9_exec_parse (bb-start-far)
[642.081263] Subtest bb-start-far: SKIP (0.000s)
[642.165205] [131/131] (383s left) kms_addfb_basic (basic)
[642.228880] Starting subtest: basic
[642.230763] Subtest basic: SUCCESS (0.000s)
[642.407221] 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.