[57.588600] Initializing watchdogs
[57.588669]   /dev/watchdog0
[57.602935] [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]
[57.607370] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.609815] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.613022] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[57.697564] Starting subtest: invalid-bad-pad
[57.700185] Subtest invalid-bad-pad: SUCCESS (0.000s)
[57.837183] [002/131] (960s left) tools_test (tools_test)
[57.885288] Starting subtest: tools_test
[57.940948] Subtest tools_test: SUCCESS (0.070s)
[58.024588] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[58.078209] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[58.139185] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[58.200649] Starting subtest: sync-unmap-cycles
[63.570881] Subtest sync-unmap-cycles: SUCCESS (5.378s)
[63.741943] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[63.844747] Starting subtest: stress-xrgb8888-ytiled
[63.847959] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[63.921066] [006/131] (954s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[64.024104] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[64.026144] Starting dynamic subtest: pipe-A-eDP-1
[80.236607] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.934s)
[80.246790] Starting dynamic subtest: pipe-B-eDP-1
[97.159551] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.410s)
[97.171250] Starting dynamic subtest: pipe-C-eDP-1
[114.159245] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.345s)
[114.171138] Starting dynamic subtest: pipe-D-eDP-1
[131.145029] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.335s)
[131.147426] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (13.028s)
[132.389676] [007/131] (885s left) api_intel_allocator (gem-pool)
[132.460045] Starting subtest: gem-pool
[132.468558] Subtest gem-pool: SUCCESS (0.009s)
[132.580145] [008/131] (885s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[132.685166] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[139.189193] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.544s)
[139.327682] [009/131] (879s left) kms_atomic_interruptible (universal-setplane-primary)
[139.439698] Starting subtest: universal-setplane-primary
[139.441922] Starting dynamic subtest: pipe-A-eDP-1
[146.867674] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.444s)
[146.869722] Subtest universal-setplane-primary: SUCCESS (7.445s)
[147.717589] [010/131] (870s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[147.828578] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[152.077425] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.257s)
[153.306447] [011/131] (865s left) gem_eio (in-flight-contexts-1us)
[153.519307] Starting subtest: in-flight-contexts-1us
[165.128663] Subtest in-flight-contexts-1us: SUCCESS (11.614s)
[165.363824] [012/131] (853s left) gem_exec_balancer (semaphore)
[165.425758] Starting subtest: semaphore
[167.090564] Subtest semaphore: SUCCESS (1.662s)
[167.461068] [013/131] (851s left) kms_chamelium_hpd (hdmi-hpd)
[167.854162] Subtest hdmi-hpd: SKIP (0.000s)
[168.674359] [014/131] (849s left) kms_flip (wf_vblank-ts-check)
[168.766581] Starting subtest: wf_vblank-ts-check
[168.768917] Starting dynamic subtest: A-eDP1
[177.662538] Dynamic subtest A-eDP1: SUCCESS (8.895s)
[177.671113] Starting dynamic subtest: B-eDP1
[186.597268] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[186.607813] Starting dynamic subtest: C-eDP1
[195.505948] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[195.518026] Starting dynamic subtest: D-eDP1
[204.447995] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[204.450506] Subtest wf_vblank-ts-check: SUCCESS (35.682s)
[205.681073] [015/131] (812s left) gem_exec_reloc (basic-gtt)
[205.743457] Subtest basic-gtt: SKIP (0.000s)
[205.829037] [016/131] (812s left) gem_exec_schedule (reorder-wide)
[206.016975] Subtest reorder-wide: SKIP (0.000s)
[206.221256] [017/131] (812s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[206.313287] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[206.315750] Starting dynamic subtest: pipe-A-eDP-1
[206.339647] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[206.350122] Starting dynamic subtest: pipe-B-eDP-1
[206.371950] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[206.380037] Starting dynamic subtest: pipe-C-eDP-1
[206.401114] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[206.410128] Starting dynamic subtest: pipe-D-eDP-1
[206.431258] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[206.435563] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[208.645225] [018/131] (810s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[208.765708] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[208.769629] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[208.904834] [019/131] (809s left) perf (polling)
[209.053432] Starting subtest: polling
[209.055607] Starting dynamic subtest: 0-rcs0
[219.076060] Dynamic subtest 0-rcs0: SUCCESS (10.025s)
[219.084738] Starting dynamic subtest: 1-vcs0
[229.092558] Dynamic subtest 1-vcs0: SUCCESS (10.017s)
[229.095407] Subtest polling: SUCCESS (20.044s)
[229.138528] [020/131] (789s left) gem_userptr_blits (probe)
[229.215386] Starting subtest: probe
[229.293345] Subtest probe: SUCCESS (0.077s)
[229.450741] [021/131] (789s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[229.556500] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[229.560674] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[229.697153] [022/131] (789s left) gem_mmap_offset (pf-nonblock)
[229.752172] Starting subtest: pf-nonblock
[229.757004] Subtest pf-nonblock: SUCCESS (0.006s)
[229.922997] [023/131] (789s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[230.027759] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[230.030084] Starting dynamic subtest: pipe-A-eDP-1
[230.055919] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.065636] Starting dynamic subtest: pipe-B-eDP-1
[230.089397] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[230.097682] Starting dynamic subtest: pipe-C-eDP-1
[230.120139] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[230.128062] Starting dynamic subtest: pipe-D-eDP-1
[230.148333] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[230.151884] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[232.208036] [024/131] (786s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[232.312307] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[232.316351] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[232.422459] [025/131] (786s left) core_getstats (basic)
[232.487343] Starting subtest: basic
[232.489635] Subtest basic: SUCCESS (0.000s)
[232.624436] [026/131] (786s left) core_getclient (basic)
[232.683917] Starting subtest: basic
[232.686014] Subtest basic: SUCCESS (0.000s)
[232.820835] [027/131] (786s left) syncobj_timeline (multi-wait-all-available-submitted)
[232.892493] Starting subtest: multi-wait-all-available-submitted
[232.894897] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[233.024144] [028/131] (786s left) gem_exec_reloc (basic-write-wc)
[233.089843] Subtest basic-write-wc: SKIP (0.000s)
[233.154690] [029/131] (786s left) kms_invalid_mode (clock-too-high)
[233.244880] Starting subtest: clock-too-high
[233.246832] Starting dynamic subtest: pipe-A-eDP-1
[233.250345] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[233.260041] Starting dynamic subtest: pipe-B-eDP-1
[233.263794] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[233.273542] Starting dynamic subtest: pipe-C-eDP-1
[233.276843] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[233.284366] Starting dynamic subtest: pipe-D-eDP-1
[233.287637] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[233.290910] Subtest clock-too-high: SKIP (0.004s)
[233.335166] [030/131] (785s left) gem_mmap_offset (bad-object)
[233.393686] Starting subtest: bad-object
[233.395612] Subtest bad-object: SUCCESS (0.001s)
[233.534963] [031/131] (785s left) syncobj_timeline (wait-all-delayed-signal)
[233.600623] Starting subtest: wait-all-delayed-signal
[233.704169] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[233.804291] [032/131] (785s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[233.904309] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[234.595349] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[234.811876] [033/131] (784s left) gem_exec_suspend (basic-s3)
[234.888882] Starting subtest: basic-S3
[234.890904] Starting dynamic subtest: smem
[254.933410] Dynamic subtest smem: SUCCESS (6.180s)
[254.936191] Subtest basic-S3: SUCCESS (6.182s)
[255.141789] [034/131] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[255.251303] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[255.255545] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[255.376984] [035/131] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[255.489029] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[255.493074] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[255.597355] [036/131] (763s left) kms_chamelium_frames (hdmi-crc-multiple)
[255.999242] Subtest hdmi-crc-multiple: SKIP (0.000s)
[256.834058] [037/131] (762s left) gem_exec_fence (syncobj-import)
[257.322531] Starting subtest: syncobj-import
[257.327902] Subtest syncobj-import: SUCCESS (0.005s)
[259.054363] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[259.057647] [038/131] (760s left) kms_legacy_colorkey (basic)
[259.155779] Starting subtest: basic
[259.157787] Starting dynamic subtest: pipe-A
[259.201110] Dynamic subtest pipe-A: SUCCESS (0.045s)
[259.212765] Starting dynamic subtest: pipe-B
[259.214616] Dynamic subtest pipe-B: SUCCESS (0.001s)
[259.222264] Starting dynamic subtest: pipe-C
[259.224525] Dynamic subtest pipe-C: SUCCESS (0.000s)
[259.232522] Starting dynamic subtest: pipe-D
[259.234752] Dynamic subtest pipe-D: SUCCESS (0.000s)
[259.236943] Subtest basic: SUCCESS (0.051s)
[259.293163] [039/131] (760s left) gem_softpin (allocator-nopin-reserve)
[259.356433] Starting subtest: allocator-nopin-reserve
[259.467112] Subtest allocator-nopin-reserve: SUCCESS (0.109s)
[259.610209] [040/131] (760s left) perf_pmu (enable-race)
[259.653246] Starting subtest: enable-race
[259.655990] Starting dynamic subtest: rcs0
[272.436702] Dynamic subtest rcs0: SUCCESS (12.816s)
[272.448431] Starting dynamic subtest: bcs0
[285.175356] Dynamic subtest bcs0: SUCCESS (12.748s)
[285.185368] Starting dynamic subtest: vcs0
[300.949402] Dynamic subtest vcs0: SUCCESS (15.767s)
[300.959404] Starting dynamic subtest: vcs1
[316.886190] Dynamic subtest vcs1: SUCCESS (15.936s)
[316.895799] Starting dynamic subtest: vecs0
[332.948974] Dynamic subtest vecs0: SUCCESS (16.065s)
[332.960671] Starting dynamic subtest: ccs0
[345.693445] Dynamic subtest ccs0: SUCCESS (12.749s)
[345.696004] Subtest enable-race: SUCCESS (86.091s)
[345.825877] [041/131] (673s left) syncobj_timeline (signal-point-0)
[345.896245] Starting subtest: signal-point-0
[345.898675] Subtest signal-point-0: SUCCESS (0.000s)
[346.026845] [042/131] (673s left) gem_tiled_wb
[346.151474] [043/131] (673s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[346.253053] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[346.255249] Starting dynamic subtest: pipe-A-eDP-1
[346.279207] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[346.288221] Starting dynamic subtest: pipe-B-eDP-1
[346.311017] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[346.319526] Starting dynamic subtest: pipe-C-eDP-1
[346.344264] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[346.359045] Starting dynamic subtest: pipe-D-eDP-1
[346.383957] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[346.388244] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[348.607072] [044/131] (671s left) gem_ctx_param (set-priority-invalid-size)
[348.669898] Starting subtest: set-priority-invalid-size
[348.672411] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[348.769060] [045/131] (671s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[348.871428] Starting subtest: plane-ctm3x4-lut1d
[348.884801] Starting dynamic subtest: pipe-A-eDP-1
[349.574252] Dynamic subtest pipe-A-eDP-1: FAIL (0.317s)
[350.326279] Starting dynamic subtest: pipe-B-eDP-1
[351.144723] Dynamic subtest pipe-B-eDP-1: FAIL (0.306s)
[351.752897] Starting dynamic subtest: pipe-C-eDP-1
[352.601198] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[353.081667] Starting dynamic subtest: pipe-D-eDP-1
[353.915012] Dynamic subtest pipe-D-eDP-1: FAIL (0.247s)
[353.917042] Subtest plane-ctm3x4-lut1d: FAIL (4.751s)
[354.486443] [046/131] (665s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[354.613699] Starting subtest: 2x-long-cursor-vs-flip-atomic
[354.618026] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[354.783538] [047/131] (665s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[354.883885] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[354.887918] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[355.005218] [048/131] (664s left) kms_feature_discovery (display-1x)
[355.108379] Starting subtest: display-1x
[355.110636] Subtest display-1x: SUCCESS (0.000s)
[355.207345] [049/131] (664s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[355.307691] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[355.311757] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[355.423521] [050/131] (664s left) i915_drm_fdinfo (most-busy-idle-check-all)
[355.466623] Starting subtest: most-busy-idle-check-all
[355.468508] Starting dynamic subtest: rcs0
[355.474416] Dynamic subtest rcs0: SKIP (0.005s)
[355.483119] Starting dynamic subtest: bcs0
[355.486579] Dynamic subtest bcs0: SKIP (0.000s)
[355.494739] Starting dynamic subtest: vcs0
[355.498316] Dynamic subtest vcs0: SKIP (0.000s)
[355.506523] Starting dynamic subtest: vcs1
[355.509958] Dynamic subtest vcs1: SKIP (0.001s)
[355.517829] Starting dynamic subtest: vecs0
[355.521305] Dynamic subtest vecs0: SKIP (0.000s)
[355.529668] Starting dynamic subtest: ccs0
[355.533509] Dynamic subtest ccs0: SKIP (0.000s)
[355.537261] Subtest most-busy-idle-check-all: SKIP (0.012s)
[355.576692] [051/131] (664s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[355.724231] Starting subtest: x-tiled-32bpp-rotate-270
[355.743513] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[355.911328] [052/131] (664s left) gem_exec_schedule (u-submit-early-slice)
[355.985721] Starting subtest: u-submit-early-slice
[355.987460] Starting dynamic subtest: rcs0
[356.026812] Dynamic subtest rcs0: SUCCESS (0.045s)
[356.038042] Starting dynamic subtest: bcs0
[356.063910] Dynamic subtest bcs0: SUCCESS (0.037s)
[356.073123] Starting dynamic subtest: vcs0
[356.104988] Dynamic subtest vcs0: SUCCESS (0.040s)
[356.114785] Starting dynamic subtest: vcs1
[356.144425] Dynamic subtest vcs1: SUCCESS (0.039s)
[356.153579] Starting dynamic subtest: vecs0
[356.192436] Dynamic subtest vecs0: SUCCESS (0.047s)
[356.201969] Starting dynamic subtest: ccs0
[356.230881] Dynamic subtest ccs0: SUCCESS (0.038s)
[356.232903] Subtest u-submit-early-slice: SUCCESS (0.249s)
[358.042792] [053/131] (662s left) gem_pxp (regular-baseline-src-copy-readible)
[358.164938] Starting subtest: regular-baseline-src-copy-readible
[358.224170] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s)
[358.394626] [054/131] (661s left) gem_exec_balancer (full-late-pulse)
[358.472704] Starting subtest: full-late-pulse
[362.863237] Subtest full-late-pulse: SUCCESS (4.392s)
[363.241382] [055/131] (657s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[363.364299] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[363.368438] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[363.497857] [056/131] (656s left) fbdev (read)
[363.541837] Starting subtest: read
[364.070949] Subtest read: SUCCESS (0.527s)
[364.157640] [057/131] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[364.264210] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[364.268655] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[364.381880] [058/131] (656s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[364.477454] Starting subtest: multiplane-rotation-cropping-top
[381.861789] Subtest multiplane-rotation-cropping-top: SUCCESS (17.382s)
[382.025148] [059/131] (638s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[382.137306] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[389.122532] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.986s)
[389.312142] [060/131] (631s left) i915_selftest (mock)
[392.819489] Starting subtest: mock
[392.821861] Starting dynamic subtest: sanitycheck
[393.562396] Dynamic subtest sanitycheck: SUCCESS (0.747s)
[393.572656] Starting dynamic subtest: shmem
[394.304576] Dynamic subtest shmem: SUCCESS (0.740s)
[394.314699] Starting dynamic subtest: fence
[402.131497] Dynamic subtest fence: SUCCESS (7.824s)
[402.141008] Starting dynamic subtest: scatterlist
[403.888683] Dynamic subtest scatterlist: SUCCESS (1.755s)
[403.898329] Starting dynamic subtest: syncmap
[407.447879] Dynamic subtest syncmap: SUCCESS (3.557s)
[407.457847] Starting dynamic subtest: uncore
[408.152583] Dynamic subtest uncore: SUCCESS (0.703s)
[408.162217] Starting dynamic subtest: ring
[408.863557] Dynamic subtest ring: SUCCESS (0.709s)
[408.873308] Starting dynamic subtest: engine
[409.592771] Dynamic subtest engine: SUCCESS (0.727s)
[409.602646] Starting dynamic subtest: timelines
[413.529424] Dynamic subtest timelines: SUCCESS (3.934s)
[413.538903] Starting dynamic subtest: requests
[417.409681] Dynamic subtest requests: SUCCESS (3.878s)
[417.419557] Starting dynamic subtest: objects
[418.319911] Dynamic subtest objects: SUCCESS (0.908s)
[418.330051] Starting dynamic subtest: phys
[419.203999] Dynamic subtest phys: SUCCESS (0.882s)
[419.213710] Starting dynamic subtest: dmabuf
[420.081763] Dynamic subtest dmabuf: SUCCESS (0.876s)
[420.091385] Starting dynamic subtest: vma
[425.514665] Dynamic subtest vma: SUCCESS (5.430s)
[425.524286] Starting dynamic subtest: evict
[426.991402] Dynamic subtest evict: SUCCESS (1.475s)
[427.001106] Starting dynamic subtest: gtt
[430.260392] Dynamic subtest gtt: SUCCESS (3.267s)
[430.270096] Starting dynamic subtest: hugepages
[431.338753] Dynamic subtest hugepages: SUCCESS (1.076s)
[431.354120] Starting dynamic subtest: memory_region
[434.058762] Dynamic subtest memory_region: SUCCESS (2.718s)
[434.061384] Subtest mock: SUCCESS (41.246s)
[434.089972] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[434.090694] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[434.093809] [061/131] (586s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[440.636923] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[440.639228] Starting dynamic subtest: pipe-A-eDP-1
[441.447776] Dynamic subtest pipe-A-eDP-1: SKIP (0.808s)
[441.456981] Starting dynamic subtest: pipe-B-eDP-1
[442.571390] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[442.576185] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.933s)
[443.796383] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[443.797668] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[443.801308] [062/131] (576s left) gem_render_copy_redux (normal)
[443.873272] Starting subtest: normal
[444.189579] Subtest normal: SUCCESS (0.315s)
[444.366252] [063/131] (576s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[444.431804] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[444.497640] [064/131] (576s left) gem_ctx_param (invalid-set-no-zeromap)
[444.557350] Starting subtest: invalid-set-no-zeromap
[444.559778] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[444.657336] [065/131] (576s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[444.760357] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[454.155689] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.398s)
[454.320029] [066/131] (566s left) i915_pm_rps (reset)
[454.380780] Starting subtest: reset
[462.788528] Subtest reset: SUCCESS (8.405s)
[462.943150] [067/131] (557s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[463.054300] Starting subtest: async-flip-with-page-flip-events-linear
[463.428420] Starting dynamic subtest: pipe-A-eDP-1
[466.159541] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.730s)
[466.533014] Starting dynamic subtest: pipe-B-eDP-1
[469.287695] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s)
[469.650590] Starting dynamic subtest: pipe-C-eDP-1
[472.417237] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.774s)
[472.782399] Starting dynamic subtest: pipe-D-eDP-1
[475.547866] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[475.550494] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.497s)
[476.762427] [068/131] (544s left) perf_pmu (module-unload)
[476.874144] Starting subtest: module-unload
[485.445134] Subtest module-unload: FAIL (8.467s)
[485.476763] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[485.477616] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[485.480654] [069/131] (535s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[487.061074] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[487.065187] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[487.171356] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[487.172693] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[487.176538] [070/131] (533s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[487.236486] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[487.336900] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[487.436640] [071/131] (533s left) kms_cursor_crc (cursor-random-256x85)
[487.690870] Starting subtest: cursor-random-256x85
[487.743619] Subtest cursor-random-256x85: SKIP (0.048s)
[487.931646] [072/131] (533s left) kms_psr (psr-sprite-plane-move)
[488.030736] Starting subtest: psr-sprite-plane-move
[488.033056] Starting dynamic subtest: eDP-1
[489.811536] Dynamic subtest eDP-1: SUCCESS (1.781s)
[489.813906] Subtest psr-sprite-plane-move: SUCCESS (1.782s)
[490.651184] [073/131] (530s left) kms_psr (fbc-pr-sprite-plane-onoff)
[490.759166] Starting subtest: fbc-pr-sprite-plane-onoff
[490.763600] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[490.854142] [074/131] (530s left) kms_pm_rpm (pm-tiling)
[493.074500] Starting subtest: pm-tiling
[493.079274] Subtest pm-tiling: SKIP (0.000s)
[493.488678] [075/131] (527s left) gem_userptr_blits (invalid-null-pointer)
[493.572874] Starting subtest: invalid-null-pointer
[493.574963] Subtest invalid-null-pointer: SUCCESS (0.001s)
[493.734448] [076/131] (527s left) kms_content_protection (lic-type-1)
[493.879707] Starting subtest: lic-type-1
[493.884101] Subtest lic-type-1: SKIP (0.000s)
[494.057546] [077/131] (527s left) kms_atomic (plane-immutable-zpos)
[494.162175] Starting subtest: plane-immutable-zpos
[494.164320] Starting dynamic subtest: pipe-A-eDP-1
[494.806615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.642s)
[494.808502] Subtest plane-immutable-zpos: SUCCESS (0.644s)
[495.673812] [078/131] (525s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[495.805044] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[495.809680] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[495.972274] [079/131] (525s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[496.072837] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[496.075149] Starting dynamic subtest: pipe-A
[497.122111] Dynamic subtest pipe-A: SUCCESS (1.050s)
[497.130449] Starting dynamic subtest: pipe-B
[499.271481] Dynamic subtest pipe-B: SUCCESS (2.148s)
[499.286215] Starting dynamic subtest: pipe-C
[500.434528] Dynamic subtest pipe-C: SUCCESS (1.162s)
[500.445716] Starting dynamic subtest: pipe-D
[501.672578] Dynamic subtest pipe-D: SUCCESS (1.237s)
[501.675152] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.601s)
[502.897060] [080/131] (518s left) kms_psr (pr-sprite-mmap-cpu)
[502.997641] Starting subtest: pr-sprite-mmap-cpu
[503.002070] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[503.095039] [081/131] (518s left) gem_ctx_persistence (legacy-engines-cleanup)
[503.169725] Starting subtest: legacy-engines-cleanup
[503.171604] Starting dynamic subtest: render
[503.280243] Dynamic subtest render: SUCCESS (0.112s)
[503.294548] Starting dynamic subtest: bsd1
[503.341207] Dynamic subtest bsd1: SUCCESS (0.058s)
[503.354662] Starting dynamic subtest: bsd2
[503.406680] Dynamic subtest bsd2: SUCCESS (0.062s)
[503.418543] Starting dynamic subtest: blt
[503.464054] Dynamic subtest blt: SUCCESS (0.055s)
[503.473544] Starting dynamic subtest: vebox
[503.528529] Dynamic subtest vebox: SUCCESS (0.062s)
[503.531152] Subtest legacy-engines-cleanup: SUCCESS (0.363s)
[503.632964] [082/131] (517s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[503.746063] Starting subtest: cursor-tearing-framebuffer-change
[503.748386] Starting dynamic subtest: pipe-A-eDP-1
[504.321576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[504.330204] Starting dynamic subtest: pipe-D-eDP-1
[505.603973] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.281s)
[505.606288] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.858s)
[506.459390] [083/131] (515s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[506.589085] Starting subtest: 2x-cursor-vs-flip-atomic
[506.593648] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[506.757383] [084/131] (514s left) kms_cursor_crc (cursor-random-32x10)
[506.923329] Starting subtest: cursor-random-32x10
[506.969946] Subtest cursor-random-32x10: SKIP (0.042s)
[507.257580] [085/131] (514s left) kms_psr (fbc-psr-primary-mmap-gtt)
[507.352305] Starting subtest: fbc-psr-primary-mmap-gtt
[507.354595] Starting dynamic subtest: eDP-1
[507.358767] Dynamic subtest eDP-1: SKIP (0.000s)
[507.363080] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[507.448182] [086/131] (514s left) kms_big_fb (linear-8bpp-rotate-0)
[507.552758] Starting subtest: linear-8bpp-rotate-0
[508.734930] Subtest linear-8bpp-rotate-0: SUCCESS (1.182s)
[508.903762] [087/131] (512s left) gem_create (create-ext-cpu-access-sanity-check)
[509.088764] Starting subtest: create-ext-cpu-access-sanity-check
[509.093530] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[509.197390] [088/131] (512s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[509.295910] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[513.529410] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.237s)
[514.674048] [089/131] (507s left) kms_pm_rpm (cursor-dpms)
[516.199812] Starting subtest: cursor-dpms
[516.204698] Subtest cursor-dpms: SKIP (0.000s)
[517.010543] [090/131] (504s left) gem_lmem_swapping (verify-random-ccs)
[517.052975] Subtest verify-random-ccs: SKIP (0.000s)
[517.097436] [091/131] (504s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[517.229938] Starting subtest: flip-vs-cursor-toggle
[525.872343] Subtest flip-vs-cursor-toggle: SUCCESS (8.645s)
[526.736518] [092/131] (495s left) gem_lmem_swapping (heavy-verify-multi)
[526.784928] Subtest heavy-verify-multi: SKIP (0.000s)
[526.827955] [093/131] (495s left) i915_pm_freq_api (freq-reset)
[526.893398] Starting subtest: freq-reset
[526.895881] Starting dynamic subtest: gt0
[527.088666] Dynamic subtest gt0: SUCCESS (0.195s)
[527.098359] Starting dynamic subtest: gt1
[527.256524] Dynamic subtest gt1: SUCCESS (0.162s)
[527.258848] Subtest freq-reset: SUCCESS (0.359s)
[527.352366] [094/131] (494s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[527.464599] Starting subtest: y-tiled-64bpp-rotate-90
[527.468617] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[527.606070] [095/131] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[527.705392] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[527.709407] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[527.840839] [096/131] (494s left) kms_dirtyfb (default-dirtyfb-ioctl)
[527.944921] Starting subtest: default-dirtyfb-ioctl
[527.946868] Starting dynamic subtest: A-eDP-1
[529.531565] Dynamic subtest A-eDP-1: SUCCESS (1.585s)
[529.533706] Subtest default-dirtyfb-ioctl: SUCCESS (1.586s)
[530.369230] [097/131] (491s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[530.461471] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[530.463772] Starting dynamic subtest: pipe-A
[530.811627] Dynamic subtest pipe-A: SUCCESS (0.353s)
[530.823527] Starting dynamic subtest: pipe-B
[532.267989] Dynamic subtest pipe-B: SUCCESS (1.456s)
[532.278568] Starting dynamic subtest: pipe-C
[533.723785] Dynamic subtest pipe-C: SUCCESS (1.454s)
[533.733157] Starting dynamic subtest: pipe-D
[535.117678] Dynamic subtest pipe-D: SUCCESS (1.393s)
[535.119986] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.661s)
[536.305114] [098/131] (485s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[536.403678] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[536.405998] Starting dynamic subtest: pipe-A-default-mode
[536.717153] Dynamic subtest pipe-A-default-mode: SKIP (0.313s)
[536.721791] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.314s)
[537.529003] [099/131] (484s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[537.649124] Starting subtest: 2x-cursor-vs-flip-legacy
[537.653537] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[537.820708] [100/131] (484s left) gem_readwrite (write-bad-handle)
[537.881038] Subtest write-bad-handle: SKIP (0.000s)
[537.949427] [101/131] (484s left) gem_reg_read (timestamp-monotonic)
[538.012037] Starting subtest: timestamp-monotonic
[542.431702] Subtest timestamp-monotonic: SUCCESS (4.421s)
[542.533275] [102/131] (479s left) kms_psr (fbc-psr2-cursor-plane-move)
[542.642306] Starting subtest: fbc-psr2-cursor-plane-move
[542.644561] Starting dynamic subtest: eDP-1
[542.648742] Dynamic subtest eDP-1: SKIP (0.000s)
[542.653035] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[542.742770] [103/131] (479s left) kms_plane_lowres (tiling-x)
[542.828287] Starting subtest: tiling-x
[542.830438] Starting dynamic subtest: pipe-A-eDP-1
[542.834765] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[543.121927] Starting dynamic subtest: pipe-B-eDP-1
[543.126321] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[543.137616] Starting dynamic subtest: pipe-C-eDP-1
[543.142064] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[543.150810] Starting dynamic subtest: pipe-D-eDP-1
[543.154670] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[543.158631] Subtest tiling-x: SKIP (0.295s)
[543.951295] [104/131] (478s left) kms_force_connector_basic (force-edid)
[544.030257] Starting subtest: force-edid
[544.396965] Subtest force-edid: SUCCESS (0.367s)
[544.561496] [105/131] (477s left) kms_getfb (getfb-handle-zero)
[544.664776] Starting subtest: getfb-handle-zero
[544.666790] Subtest getfb-handle-zero: SUCCESS (0.000s)
[544.796690] [106/131] (477s left) perf (missing-sample-flags)
[544.934099] Starting subtest: missing-sample-flags
[544.935958] Subtest missing-sample-flags: SUCCESS (0.000s)
[544.980315] [107/131] (477s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[545.075266] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[551.750906] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.678s)
[551.942057] [108/131] (470s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[552.052575] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[552.056819] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[552.189724] [109/131] (470s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[552.296611] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[552.300537] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[552.447297] [110/131] (470s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[552.557950] Starting subtest: 4-tiled-8bpp-rotate-180
[553.782374] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.224s)
[553.968003] [111/131] (468s left) gem_exec_fence (syncobj-timeline-repeat)
[554.520604] Starting subtest: syncobj-timeline-repeat
[554.754871] Subtest syncobj-timeline-repeat: SUCCESS (0.234s)
[556.015583] [112/131] (466s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[556.120885] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[563.377087] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.259s)
[563.560620] [113/131] (459s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[563.621843] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[563.624114] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[563.762349] [114/131] (459s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[563.869790] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[567.585269] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.720s)
[568.783944] [115/131] (454s left) gem_exec_schedule (lateslice)
[568.865701] Starting subtest: lateslice
[568.867602] Starting dynamic subtest: rcs0
[568.876217] Dynamic subtest rcs0: SUCCESS (0.021s)
[568.887190] Starting dynamic subtest: bcs0
[568.897162] Dynamic subtest bcs0: SUCCESS (0.020s)
[568.906257] Starting dynamic subtest: vcs0
[568.915168] Dynamic subtest vcs0: SUCCESS (0.018s)
[568.924367] Starting dynamic subtest: vcs1
[568.933814] Dynamic subtest vcs1: SUCCESS (0.018s)
[568.943640] Starting dynamic subtest: vecs0
[568.953134] Dynamic subtest vecs0: SUCCESS (0.018s)
[568.965325] Starting dynamic subtest: ccs0
[568.971249] Dynamic subtest ccs0: SUCCESS (0.017s)
[568.973445] Subtest lateslice: SUCCESS (0.117s)
[571.095650] [116/131] (451s left) kms_vblank (query-idle-hang)
[571.200441] Starting subtest: query-idle-hang
[571.202750] Starting dynamic subtest: pipe-A-eDP-1
[597.827518] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.633s)
[597.842522] Starting dynamic subtest: pipe-D-eDP-1
[612.686646] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.860s)
[612.688995] Subtest query-idle-hang: SUCCESS (41.498s)
[613.545943] [117/131] (409s left) syncobj_wait (reset-multiple-signaled)
[613.606179] Starting subtest: reset-multiple-signaled
[613.608451] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[613.739625] [118/131] (409s left) kms_flip_event_leak (basic)
[613.835736] Starting subtest: basic
[613.837660] Starting dynamic subtest: pipe-A-eDP-1
[614.256934] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.422s)
[614.269188] Starting dynamic subtest: pipe-B-eDP-1
[615.408904] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.149s)
[615.418545] Starting dynamic subtest: pipe-C-eDP-1
[616.493604] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.086s)
[616.503585] Starting dynamic subtest: pipe-D-eDP-1
[617.591586] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.097s)
[617.593966] Subtest basic: SUCCESS (3.760s)
[618.448769] [119/131] (404s left) gem_pwrite_snooped
[618.623897] [120/131] (404s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[618.688812] Starting subtest: yf-tiled-ccs-to-y-tiled
[618.693513] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[618.900191] [121/131] (404s left) gem_ctx_shared (q-independent)
[618.976052] Starting subtest: Q-independent
[618.978524] Starting dynamic subtest: rcs0
[619.042456] Dynamic subtest rcs0: SUCCESS (0.066s)
[619.054647] Starting dynamic subtest: vcs0
[619.084504] Dynamic subtest vcs0: SUCCESS (0.042s)
[619.094667] Starting dynamic subtest: vcs1
[619.122664] Dynamic subtest vcs1: SUCCESS (0.037s)
[619.132687] Starting dynamic subtest: vecs0
[619.159860] Dynamic subtest vecs0: SUCCESS (0.036s)
[619.169921] Starting dynamic subtest: ccs0
[619.199994] Dynamic subtest ccs0: SUCCESS (0.039s)
[619.202322] Subtest Q-independent: SUCCESS (0.224s)
[621.104956] [122/131] (402s left) prime_mmap (test_userptr)
[621.182188] Starting subtest: test_userptr
[621.184710] Starting dynamic subtest: test_userptr-smem
[621.186962] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[621.188905] Subtest test_userptr: SUCCESS (0.001s)
[621.321801] [123/131] (401s left) kms_addfb_basic (bad-pitch-65536)
[621.380116] Starting subtest: bad-pitch-65536
[621.382554] Subtest bad-pitch-65536: SUCCESS (0.000s)
[621.564396] [124/131] (401s left) prime_self_import (basic-with_fd_dup)
[621.609172] Starting subtest: basic-with_fd_dup
[621.635771] Subtest basic-with_fd_dup: SUCCESS (0.025s)
[621.778638] [125/131] (401s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[621.875847] Starting subtest: primary-y-tiled-reflect-x-0
[621.936336] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[622.058237] [126/131] (401s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[622.157577] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[622.159399] Starting dynamic subtest: pipe-A-eDP-1
[622.177708] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[622.189068] Starting dynamic subtest: pipe-B-eDP-1
[622.206446] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[622.215497] Starting dynamic subtest: pipe-C-eDP-1
[622.232815] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[622.241916] Starting dynamic subtest: pipe-D-eDP-1
[622.261179] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[622.264659] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[624.446317] [127/131] (398s left) kms_addfb_basic (unused-modifier)
[624.504540] Starting subtest: unused-modifier
[624.506726] Subtest unused-modifier: SUCCESS (0.000s)
[624.679578] [128/131] (398s left) kms_vblank (wait-idle)
[624.780095] Starting subtest: wait-idle
[624.782216] Starting dynamic subtest: pipe-A-eDP-1
[626.532926] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[626.548551] Starting dynamic subtest: pipe-D-eDP-1
[628.940273] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.403s)
[628.942564] Subtest wait-idle: SUCCESS (4.160s)
[629.759309] [129/131] (393s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[629.885160] Starting subtest: cursorA-vs-flipA-toggle
[640.999183] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.114s)
[641.835766] [130/131] (381s left) gen9_exec_parse (bb-start-far)
[641.903027] Subtest bb-start-far: SKIP (0.000s)
[641.974695] [131/131] (381s left) kms_addfb_basic (basic)
[642.029636] Starting subtest: basic
[642.031504] Subtest basic: SUCCESS (0.000s)
[642.190310] 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.