[57.429815] Initializing watchdogs
[57.429861]   /dev/watchdog0
[57.443671] [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.447826] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.450067] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.453265] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[57.527233] Starting subtest: invalid-bad-pad
[57.529591] Subtest invalid-bad-pad: SUCCESS (0.000s)
[57.658836] [002/131] (960s left) tools_test (tools_test)
[57.706795] Starting subtest: tools_test
[57.750669] Subtest tools_test: SUCCESS (0.061s)
[57.836045] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[57.896121] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[57.964740] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[58.033162] Starting subtest: sync-unmap-cycles
[63.387740] Subtest sync-unmap-cycles: SUCCESS (5.373s)
[63.534233] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[63.643312] Starting subtest: stress-xrgb8888-ytiled
[63.647213] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[63.704686] [006/131] (954s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[63.800565] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[63.802653] Starting dynamic subtest: pipe-A-eDP-1
[80.352725] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.930s)
[80.370054] Starting dynamic subtest: pipe-B-eDP-1
[97.316645] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.431s)
[97.325916] Starting dynamic subtest: pipe-C-eDP-1
[114.280295] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.338s)
[114.288900] Starting dynamic subtest: pipe-D-eDP-1
[131.298826] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.365s)
[131.300993] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (13.067s)
[132.535195] [007/131] (885s left) api_intel_allocator (gem-pool)
[132.608272] Starting subtest: gem-pool
[132.615030] Subtest gem-pool: SUCCESS (0.009s)
[132.754023] [008/131] (885s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[132.848965] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[139.294244] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.516s)
[139.440743] [009/131] (878s left) kms_atomic_interruptible (universal-setplane-primary)
[139.546249] Starting subtest: universal-setplane-primary
[139.548420] Starting dynamic subtest: pipe-A-eDP-1
[146.916099] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.401s)
[146.918137] Subtest universal-setplane-primary: SUCCESS (7.402s)
[147.739460] [010/131] (870s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[147.851039] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[152.105343] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.268s)
[153.323430] [011/131] (865s left) gem_eio (in-flight-contexts-1us)
[153.539269] Starting subtest: in-flight-contexts-1us
[165.489364] Subtest in-flight-contexts-1us: SUCCESS (11.956s)
[165.692227] [012/131] (852s left) gem_exec_balancer (semaphore)
[165.765800] Starting subtest: semaphore
[167.485602] Subtest semaphore: SUCCESS (1.717s)
[167.835614] [013/131] (850s left) kms_chamelium_hpd (hdmi-hpd)
[168.217883] Subtest hdmi-hpd: SKIP (0.000s)
[168.999194] [014/131] (849s left) kms_flip (wf_vblank-ts-check)
[169.097940] Starting subtest: wf_vblank-ts-check
[169.099984] Starting dynamic subtest: A-eDP1
[178.062181] Dynamic subtest A-eDP1: SUCCESS (8.966s)
[178.072660] Starting dynamic subtest: B-eDP1
[186.988049] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[186.996786] Starting dynamic subtest: C-eDP1
[195.913116] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[195.921537] Starting dynamic subtest: D-eDP1
[204.846189] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[204.848932] Subtest wf_vblank-ts-check: SUCCESS (35.758s)
[206.095306] [015/131] (812s left) gem_exec_reloc (basic-gtt)
[206.158818] Subtest basic-gtt: SKIP (0.000s)
[206.244331] [016/131] (812s left) gem_exec_schedule (reorder-wide)
[206.426916] Subtest reorder-wide: SKIP (0.000s)
[206.628146] [017/131] (811s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[206.740477] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[206.742847] Starting dynamic subtest: pipe-A-eDP-1
[206.766757] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[206.776881] Starting dynamic subtest: pipe-B-eDP-1
[206.797406] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[206.804946] Starting dynamic subtest: pipe-C-eDP-1
[206.825874] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[206.833475] Starting dynamic subtest: pipe-D-eDP-1
[206.854575] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[206.858888] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[208.983281] [018/131] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[209.076770] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[209.081140] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[209.211823] [019/131] (809s left) perf (polling)
[209.345946] Starting subtest: polling
[209.348124] Starting dynamic subtest: 0-rcs0
[219.357508] Dynamic subtest 0-rcs0: SUCCESS (10.015s)
[219.367079] Starting dynamic subtest: 1-vcs0
[229.377149] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[229.380196] Subtest polling: SUCCESS (20.037s)
[229.425471] [020/131] (789s left) gem_userptr_blits (probe)
[229.503701] Starting subtest: probe
[229.581943] Subtest probe: SUCCESS (0.077s)
[229.744838] [021/131] (788s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[229.862662] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[229.866833] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[229.994856] [022/131] (788s left) gem_mmap_offset (pf-nonblock)
[230.052482] Starting subtest: pf-nonblock
[230.057279] Subtest pf-nonblock: SUCCESS (0.006s)
[230.222569] [023/131] (788s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[230.321260] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[230.323492] Starting dynamic subtest: pipe-A-eDP-1
[230.347778] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.356780] Starting dynamic subtest: pipe-B-eDP-1
[230.381522] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[230.389699] Starting dynamic subtest: pipe-C-eDP-1
[230.409775] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[230.417465] Starting dynamic subtest: pipe-D-eDP-1
[230.438099] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[230.441681] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[232.635100] [024/131] (786s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[232.749719] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[232.754142] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[232.877494] [025/131] (785s left) core_getstats (basic)
[232.939317] Starting subtest: basic
[232.941489] Subtest basic: SUCCESS (0.000s)
[233.069191] [026/131] (785s left) core_getclient (basic)
[233.118905] Starting subtest: basic
[233.121262] Subtest basic: SUCCESS (0.000s)
[233.246551] [027/131] (785s left) syncobj_timeline (multi-wait-all-available-submitted)
[233.307935] Starting subtest: multi-wait-all-available-submitted
[233.310070] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[233.438893] [028/131] (785s left) gem_exec_reloc (basic-write-wc)
[233.510728] Subtest basic-write-wc: SKIP (0.000s)
[233.598791] [029/131] (785s left) kms_invalid_mode (clock-too-high)
[233.698250] Starting subtest: clock-too-high
[233.700163] Starting dynamic subtest: pipe-A-eDP-1
[233.703656] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[233.712278] Starting dynamic subtest: pipe-B-eDP-1
[233.715592] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[233.723839] Starting dynamic subtest: pipe-C-eDP-1
[233.727285] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[233.734668] Starting dynamic subtest: pipe-D-eDP-1
[233.738028] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[233.741446] Subtest clock-too-high: SKIP (0.004s)
[233.794499] [030/131] (785s left) gem_mmap_offset (bad-object)
[233.848279] Starting subtest: bad-object
[233.849854] Subtest bad-object: SUCCESS (0.001s)
[233.994920] [031/131] (785s left) syncobj_timeline (wait-all-delayed-signal)
[234.047545] Starting subtest: wait-all-delayed-signal
[234.149549] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[234.248468] [032/131] (784s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[234.360871] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[235.140909] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s)
[235.315972] [033/131] (783s left) gem_exec_suspend (basic-s3)
[235.394384] Starting subtest: basic-S3
[235.396658] Starting dynamic subtest: smem
[256.099719] Dynamic subtest smem: SUCCESS (7.101s)
[256.102295] Subtest basic-S3: SUCCESS (7.102s)
[256.303423] [034/131] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[256.433353] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[256.437819] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[256.568658] [035/131] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[256.669007] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[256.673382] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[256.795379] [036/131] (762s left) kms_chamelium_frames (hdmi-crc-multiple)
[257.184030] Subtest hdmi-crc-multiple: SKIP (0.000s)
[257.964585] [037/131] (761s left) gem_exec_fence (syncobj-import)
[258.456821] Starting subtest: syncobj-import
[258.462144] Subtest syncobj-import: SUCCESS (0.005s)
[260.191012] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[260.194158] [038/131] (759s left) kms_legacy_colorkey (basic)
[260.292713] Starting subtest: basic
[260.294821] Starting dynamic subtest: pipe-A
[260.335259] Dynamic subtest pipe-A: SUCCESS (0.045s)
[260.346354] Starting dynamic subtest: pipe-B
[260.348165] Dynamic subtest pipe-B: SUCCESS (0.001s)
[260.355802] Starting dynamic subtest: pipe-C
[260.358072] Dynamic subtest pipe-C: SUCCESS (0.000s)
[260.366056] Starting dynamic subtest: pipe-D
[260.368189] Dynamic subtest pipe-D: SUCCESS (0.000s)
[260.370229] Subtest basic: SUCCESS (0.050s)
[260.426336] [039/131] (758s left) gem_softpin (allocator-nopin-reserve)
[260.487720] Starting subtest: allocator-nopin-reserve
[260.585166] Subtest allocator-nopin-reserve: SUCCESS (0.098s)
[260.742910] [040/131] (758s left) perf_pmu (enable-race)
[260.787638] Starting subtest: enable-race
[260.789884] Starting dynamic subtest: rcs0
[273.562109] Dynamic subtest rcs0: SUCCESS (12.835s)
[273.571783] Starting dynamic subtest: bcs0
[286.310174] Dynamic subtest bcs0: SUCCESS (12.763s)
[286.320952] Starting dynamic subtest: vcs0
[302.052466] Dynamic subtest vcs0: SUCCESS (15.735s)
[302.063046] Starting dynamic subtest: vcs1
[318.052844] Dynamic subtest vcs1: SUCCESS (16.000s)
[318.064384] Starting dynamic subtest: vecs0
[334.115403] Dynamic subtest vecs0: SUCCESS (16.065s)
[334.127333] Starting dynamic subtest: ccs0
[346.858461] Dynamic subtest ccs0: SUCCESS (12.747s)
[346.860896] Subtest enable-race: SUCCESS (86.155s)
[346.995486] [041/131] (672s left) syncobj_timeline (signal-point-0)
[347.052834] Starting subtest: signal-point-0
[347.055139] Subtest signal-point-0: SUCCESS (0.000s)
[347.200705] [042/131] (672s left) gem_tiled_wb
[347.324588] [043/131] (672s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[347.423907] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[347.426210] Starting dynamic subtest: pipe-A-eDP-1
[347.450617] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[347.461057] Starting dynamic subtest: pipe-B-eDP-1
[347.484143] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[347.492690] Starting dynamic subtest: pipe-C-eDP-1
[347.515697] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[347.524763] Starting dynamic subtest: pipe-D-eDP-1
[347.551072] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[347.555320] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[349.651468] [044/131] (669s left) gem_ctx_param (set-priority-invalid-size)
[349.704500] Starting subtest: set-priority-invalid-size
[349.706830] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[349.805025] [045/131] (669s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[349.908870] Starting subtest: plane-ctm3x4-lut1d
[349.921395] Starting dynamic subtest: pipe-A-eDP-1
[350.631547] Dynamic subtest pipe-A-eDP-1: FAIL (0.323s)
[351.317885] Starting dynamic subtest: pipe-B-eDP-1
[352.157456] Dynamic subtest pipe-B-eDP-1: FAIL (0.325s)
[352.735669] Starting dynamic subtest: pipe-C-eDP-1
[353.599392] Dynamic subtest pipe-C-eDP-1: FAIL (0.268s)
[354.066306] Starting dynamic subtest: pipe-D-eDP-1
[354.900680] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[354.902724] Subtest plane-ctm3x4-lut1d: FAIL (4.663s)
[355.468418] [046/131] (664s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[355.593680] Starting subtest: 2x-long-cursor-vs-flip-atomic
[355.598445] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[355.782007] [047/131] (663s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[355.885279] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[355.889771] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[356.033117] [048/131] (663s left) kms_feature_discovery (display-1x)
[356.136188] Starting subtest: display-1x
[356.138482] Subtest display-1x: SUCCESS (0.000s)
[356.231325] [049/131] (663s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[356.326029] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[356.330514] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[356.455883] [050/131] (663s left) i915_drm_fdinfo (most-busy-idle-check-all)
[356.500824] Starting subtest: most-busy-idle-check-all
[356.502652] Starting dynamic subtest: rcs0
[356.506462] Dynamic subtest rcs0: SKIP (0.004s)
[356.515960] Starting dynamic subtest: bcs0
[356.519268] Dynamic subtest bcs0: SKIP (0.000s)
[356.527016] Starting dynamic subtest: vcs0
[356.531040] Dynamic subtest vcs0: SKIP (0.000s)
[356.540807] Starting dynamic subtest: vcs1
[356.544192] Dynamic subtest vcs1: SKIP (0.000s)
[356.552396] Starting dynamic subtest: vecs0
[356.555733] Dynamic subtest vecs0: SKIP (0.000s)
[356.563607] Starting dynamic subtest: ccs0
[356.567130] Dynamic subtest ccs0: SKIP (0.000s)
[356.570496] Subtest most-busy-idle-check-all: SKIP (0.008s)
[356.604853] [051/131] (663s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[356.734947] Starting subtest: x-tiled-32bpp-rotate-270
[356.754939] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[356.907185] [052/131] (663s left) gem_exec_schedule (u-submit-early-slice)
[356.974955] Starting subtest: u-submit-early-slice
[356.977155] Starting dynamic subtest: rcs0
[357.016017] Dynamic subtest rcs0: SUCCESS (0.045s)
[357.027752] Starting dynamic subtest: bcs0
[357.074825] Dynamic subtest bcs0: SUCCESS (0.058s)
[357.085608] Starting dynamic subtest: vcs0
[357.115291] Dynamic subtest vcs0: SUCCESS (0.040s)
[357.124819] Starting dynamic subtest: vcs1
[357.154213] Dynamic subtest vcs1: SUCCESS (0.038s)
[357.164035] Starting dynamic subtest: vecs0
[357.201249] Dynamic subtest vecs0: SUCCESS (0.046s)
[357.211816] Starting dynamic subtest: ccs0
[357.239832] Dynamic subtest ccs0: SUCCESS (0.038s)
[357.241923] Subtest u-submit-early-slice: SUCCESS (0.269s)
[359.198111] [053/131] (660s left) gem_pxp (regular-baseline-src-copy-readible)
[359.329676] Starting subtest: regular-baseline-src-copy-readible
[359.389970] Subtest regular-baseline-src-copy-readible: SUCCESS (0.064s)
[359.562511] [054/131] (660s left) gem_exec_balancer (full-late-pulse)
[359.636707] Starting subtest: full-late-pulse
[363.983929] Subtest full-late-pulse: SUCCESS (4.345s)
[364.366834] [055/131] (655s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[364.482172] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[364.486472] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[364.620944] [056/131] (655s left) fbdev (read)
[364.659290] Starting subtest: read
[365.508144] Subtest read: SUCCESS (0.847s)
[365.600587] [057/131] (654s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[365.713024] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[365.717335] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[365.847933] [058/131] (654s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[365.936787] Starting subtest: multiplane-rotation-cropping-top
[383.308730] Subtest multiplane-rotation-cropping-top: SUCCESS (17.371s)
[383.451937] [059/131] (636s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[383.578905] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[390.694430] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.116s)
[390.894280] [060/131] (629s left) i915_selftest (mock)
[394.452412] Starting subtest: mock
[394.454727] Starting dynamic subtest: sanitycheck
[395.198350] Dynamic subtest sanitycheck: SUCCESS (0.746s)
[395.207775] Starting dynamic subtest: shmem
[395.945155] Dynamic subtest shmem: SUCCESS (0.745s)
[395.954356] Starting dynamic subtest: fence
[404.279493] Dynamic subtest fence: SUCCESS (8.330s)
[404.288847] Starting dynamic subtest: scatterlist
[405.981346] Dynamic subtest scatterlist: SUCCESS (1.700s)
[405.991590] Starting dynamic subtest: syncmap
[409.305715] Dynamic subtest syncmap: SUCCESS (3.322s)
[409.315773] Starting dynamic subtest: uncore
[410.030489] Dynamic subtest uncore: SUCCESS (0.723s)
[410.046387] Starting dynamic subtest: ring
[410.717282] Dynamic subtest ring: SUCCESS (0.685s)
[410.726839] Starting dynamic subtest: engine
[411.454282] Dynamic subtest engine: SUCCESS (0.735s)
[411.464071] Starting dynamic subtest: timelines
[415.403493] Dynamic subtest timelines: SUCCESS (3.946s)
[415.413000] Starting dynamic subtest: requests
[419.069085] Dynamic subtest requests: SUCCESS (3.664s)
[419.078731] Starting dynamic subtest: objects
[419.974943] Dynamic subtest objects: SUCCESS (0.904s)
[419.984327] Starting dynamic subtest: phys
[420.835633] Dynamic subtest phys: SUCCESS (0.858s)
[420.844872] Starting dynamic subtest: dmabuf
[421.700728] Dynamic subtest dmabuf: SUCCESS (0.863s)
[421.710493] Starting dynamic subtest: vma
[427.137329] Dynamic subtest vma: SUCCESS (5.434s)
[427.147002] Starting dynamic subtest: evict
[428.622185] Dynamic subtest evict: SUCCESS (1.482s)
[428.631474] Starting dynamic subtest: gtt
[431.876095] Dynamic subtest gtt: SUCCESS (3.252s)
[431.890811] Starting dynamic subtest: hugepages
[432.840997] Dynamic subtest hugepages: SUCCESS (0.963s)
[432.851063] Starting dynamic subtest: memory_region
[435.509468] Dynamic subtest memory_region: SUCCESS (2.666s)
[435.512042] Subtest mock: SUCCESS (41.057s)
[435.541199] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[435.542033] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[435.545409] [061/131] (584s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[442.093251] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[442.095678] Starting dynamic subtest: pipe-A-eDP-1
[442.896158] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s)
[442.904623] Starting dynamic subtest: pipe-B-eDP-1
[444.021600] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[444.025871] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.926s)
[445.253974] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[445.255221] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[445.258873] [062/131] (575s left) gem_render_copy_redux (normal)
[445.332340] Starting subtest: normal
[445.608845] Subtest normal: SUCCESS (0.276s)
[445.747984] [063/131] (574s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[445.816047] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[445.899575] [064/131] (574s left) gem_ctx_param (invalid-set-no-zeromap)
[445.950129] Starting subtest: invalid-set-no-zeromap
[445.952498] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[446.048178] [065/131] (574s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[446.138553] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[455.553175] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.417s)
[455.714778] [066/131] (564s left) i915_pm_rps (reset)
[455.782880] Starting subtest: reset
[464.203792] Subtest reset: SUCCESS (8.419s)
[464.376027] [067/131] (556s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[464.490246] Starting subtest: async-flip-with-page-flip-events-linear
[464.872033] Starting dynamic subtest: pipe-A-eDP-1
[467.645112] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.773s)
[468.010252] Starting dynamic subtest: pipe-B-eDP-1
[470.771943] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s)
[471.143835] Starting dynamic subtest: pipe-C-eDP-1
[473.908718] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.770s)
[474.268643] Starting dynamic subtest: pipe-D-eDP-1
[477.045418] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.782s)
[477.048006] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.558s)
[478.252369] [068/131] (542s left) perf_pmu (module-unload)
[478.364730] Starting subtest: module-unload
[486.826227] Subtest module-unload: FAIL (8.355s)
[486.874353] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[486.875176] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[486.878576] [069/131] (533s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[488.560506] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[488.564716] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[488.667039] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[488.668350] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[488.671993] [070/131] (532s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[488.736026] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[488.840443] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[488.939129] [071/131] (531s left) kms_cursor_crc (cursor-random-256x85)
[489.203850] Starting subtest: cursor-random-256x85
[489.268604] Subtest cursor-random-256x85: SKIP (0.058s)
[489.482343] [072/131] (531s left) kms_psr (psr-sprite-plane-move)
[489.593662] Starting subtest: psr-sprite-plane-move
[489.595961] Starting dynamic subtest: eDP-1
[491.370508] Dynamic subtest eDP-1: SUCCESS (1.778s)
[491.372828] Subtest psr-sprite-plane-move: SUCCESS (1.779s)
[492.218954] [073/131] (528s left) kms_psr (fbc-pr-sprite-plane-onoff)
[492.316399] Starting subtest: fbc-pr-sprite-plane-onoff
[492.320508] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[492.411336] [074/131] (528s left) kms_pm_rpm (pm-tiling)
[494.249494] Starting subtest: pm-tiling
[494.254848] Subtest pm-tiling: SKIP (0.000s)
[494.658029] [075/131] (526s left) gem_userptr_blits (invalid-null-pointer)
[494.738493] Starting subtest: invalid-null-pointer
[494.740806] Subtest invalid-null-pointer: SUCCESS (0.001s)
[494.899013] [076/131] (526s left) kms_content_protection (lic-type-1)
[495.042455] Starting subtest: lic-type-1
[495.046897] Subtest lic-type-1: SKIP (0.000s)
[495.190269] [077/131] (525s left) kms_atomic (plane-immutable-zpos)
[495.278055] Starting subtest: plane-immutable-zpos
[495.280295] Starting dynamic subtest: pipe-A-eDP-1
[495.902809] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.624s)
[495.904949] Subtest plane-immutable-zpos: SUCCESS (0.625s)
[496.791617] [078/131] (524s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[496.917576] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[496.921948] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[497.087708] [079/131] (523s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[497.183886] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[497.186059] Starting dynamic subtest: pipe-A
[498.254978] Dynamic subtest pipe-A: SUCCESS (1.073s)
[498.271514] Starting dynamic subtest: pipe-B
[500.370594] Dynamic subtest pipe-B: SUCCESS (2.114s)
[500.378603] Starting dynamic subtest: pipe-C
[501.568433] Dynamic subtest pipe-C: SUCCESS (1.197s)
[501.576558] Starting dynamic subtest: pipe-D
[502.713486] Dynamic subtest pipe-D: SUCCESS (1.144s)
[502.715792] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.533s)
[503.932037] [080/131] (517s left) kms_psr (pr-sprite-mmap-cpu)
[504.024763] Starting subtest: pr-sprite-mmap-cpu
[504.029103] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[504.121723] [081/131] (517s left) gem_ctx_persistence (legacy-engines-cleanup)
[504.185675] Starting subtest: legacy-engines-cleanup
[504.188124] Starting dynamic subtest: render
[504.235757] Dynamic subtest render: SUCCESS (0.049s)
[504.245066] Starting dynamic subtest: bsd1
[504.331765] Dynamic subtest bsd1: SUCCESS (0.094s)
[504.346051] Starting dynamic subtest: bsd2
[504.389681] Dynamic subtest bsd2: SUCCESS (0.054s)
[504.402071] Starting dynamic subtest: blt
[504.452021] Dynamic subtest blt: SUCCESS (0.058s)
[504.464166] Starting dynamic subtest: vebox
[504.512132] Dynamic subtest vebox: SUCCESS (0.057s)
[504.514934] Subtest legacy-engines-cleanup: SUCCESS (0.327s)
[504.628960] [082/131] (516s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[504.753945] Starting subtest: cursor-tearing-framebuffer-change
[504.756230] Starting dynamic subtest: pipe-A-eDP-1
[505.322121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[505.331468] Starting dynamic subtest: pipe-D-eDP-1
[506.524632] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.204s)
[506.527154] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.771s)
[507.383481] [083/131] (513s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[507.506509] Starting subtest: 2x-cursor-vs-flip-atomic
[507.510881] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[507.672706] [084/131] (513s left) kms_cursor_crc (cursor-random-32x10)
[507.834773] Starting subtest: cursor-random-32x10
[507.879712] Subtest cursor-random-32x10: SKIP (0.041s)
[508.180459] [085/131] (513s left) kms_psr (fbc-psr-primary-mmap-gtt)
[508.283179] Starting subtest: fbc-psr-primary-mmap-gtt
[508.285427] Starting dynamic subtest: eDP-1
[508.289698] Dynamic subtest eDP-1: SKIP (0.000s)
[508.293277] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[508.381017] [086/131] (512s left) kms_big_fb (linear-8bpp-rotate-0)
[508.484784] Starting subtest: linear-8bpp-rotate-0
[509.721393] Subtest linear-8bpp-rotate-0: SUCCESS (1.237s)
[509.900934] [087/131] (511s left) gem_create (create-ext-cpu-access-sanity-check)
[510.076887] Starting subtest: create-ext-cpu-access-sanity-check
[510.082029] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[510.174922] [088/131] (511s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[510.287401] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[514.606430] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.323s)
[515.782054] [089/131] (505s left) kms_pm_rpm (cursor-dpms)
[517.317396] Starting subtest: cursor-dpms
[517.322690] Subtest cursor-dpms: SKIP (0.000s)
[518.102563] [090/131] (503s left) gem_lmem_swapping (verify-random-ccs)
[518.144517] Subtest verify-random-ccs: SKIP (0.000s)
[518.190641] [091/131] (503s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[518.308877] Starting subtest: flip-vs-cursor-toggle
[526.910789] Subtest flip-vs-cursor-toggle: SUCCESS (8.606s)
[527.726648] [092/131] (493s left) gem_lmem_swapping (heavy-verify-multi)
[527.770566] Subtest heavy-verify-multi: SKIP (0.000s)
[527.811508] [093/131] (493s left) i915_pm_freq_api (freq-reset)
[527.884754] Starting subtest: freq-reset
[527.887129] Starting dynamic subtest: gt0
[528.084257] Dynamic subtest gt0: SUCCESS (0.197s)
[528.092412] Starting dynamic subtest: gt1
[528.248204] Dynamic subtest gt1: SUCCESS (0.163s)
[528.251072] Subtest freq-reset: SUCCESS (0.362s)
[528.346301] [094/131] (493s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[528.454679] Starting subtest: y-tiled-64bpp-rotate-90
[528.459074] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[528.571861] [095/131] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[528.685371] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[528.689552] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[528.833602] [096/131] (492s left) kms_dirtyfb (default-dirtyfb-ioctl)
[528.943842] Starting subtest: default-dirtyfb-ioctl
[528.945834] Starting dynamic subtest: A-eDP-1
[530.529586] Dynamic subtest A-eDP-1: SUCCESS (1.587s)
[530.532007] Subtest default-dirtyfb-ioctl: SUCCESS (1.588s)
[531.363316] [097/131] (490s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[531.466226] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[531.468547] Starting dynamic subtest: pipe-A
[531.806516] Dynamic subtest pipe-A: SUCCESS (0.342s)
[531.815635] Starting dynamic subtest: pipe-B
[533.244246] Dynamic subtest pipe-B: SUCCESS (1.437s)
[533.256399] Starting dynamic subtest: pipe-C
[534.669638] Dynamic subtest pipe-C: SUCCESS (1.425s)
[534.679428] Starting dynamic subtest: pipe-D
[536.108063] Dynamic subtest pipe-D: SUCCESS (1.438s)
[536.110349] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.646s)
[537.277173] [098/131] (484s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[537.373353] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[537.375635] Starting dynamic subtest: pipe-A-default-mode
[537.690152] Dynamic subtest pipe-A-default-mode: SKIP (0.316s)
[537.694404] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.318s)
[538.509406] [099/131] (483s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[538.636309] Starting subtest: 2x-cursor-vs-flip-legacy
[538.640671] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[538.806932] [100/131] (483s left) gem_readwrite (write-bad-handle)
[538.865487] Subtest write-bad-handle: SKIP (0.000s)
[538.933414] [101/131] (483s left) gem_reg_read (timestamp-monotonic)
[538.992552] Starting subtest: timestamp-monotonic
[543.585201] Subtest timestamp-monotonic: SUCCESS (4.593s)
[543.704937] [102/131] (478s left) kms_psr (fbc-psr2-cursor-plane-move)
[543.804927] Starting subtest: fbc-psr2-cursor-plane-move
[543.807207] Starting dynamic subtest: eDP-1
[543.811193] Dynamic subtest eDP-1: SKIP (0.000s)
[543.815165] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[543.901832] [103/131] (478s left) kms_plane_lowres (tiling-x)
[544.004324] Starting subtest: tiling-x
[544.006443] Starting dynamic subtest: pipe-A-eDP-1
[544.010795] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[544.297264] Starting dynamic subtest: pipe-B-eDP-1
[544.301576] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[544.312467] Starting dynamic subtest: pipe-C-eDP-1
[544.316973] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[544.325741] Starting dynamic subtest: pipe-D-eDP-1
[544.329963] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[544.334275] Subtest tiling-x: SKIP (0.292s)
[545.129437] [104/131] (477s left) kms_force_connector_basic (force-edid)
[545.206754] Starting subtest: force-edid
[545.574417] Subtest force-edid: SUCCESS (0.368s)
[545.739266] [105/131] (476s left) kms_getfb (getfb-handle-zero)
[545.839439] Starting subtest: getfb-handle-zero
[545.841579] Subtest getfb-handle-zero: SUCCESS (0.000s)
[545.965934] [106/131] (476s left) perf (missing-sample-flags)
[546.111955] Starting subtest: missing-sample-flags
[546.113664] Subtest missing-sample-flags: SUCCESS (0.000s)
[546.160524] [107/131] (476s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[546.254138] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[552.784170] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.532s)
[552.934619] [108/131] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[553.037553] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[553.041985] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[553.168951] [109/131] (469s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[553.264009] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[553.268485] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[553.400758] [110/131] (468s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[553.503360] Starting subtest: 4-tiled-8bpp-rotate-180
[554.715106] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.213s)
[554.875325] [111/131] (467s left) gem_exec_fence (syncobj-timeline-repeat)
[555.419225] Starting subtest: syncobj-timeline-repeat
[555.643649] Subtest syncobj-timeline-repeat: SUCCESS (0.225s)
[557.231345] [112/131] (465s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[557.336484] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[564.513848] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.181s)
[564.683510] [113/131] (457s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[564.735063] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[564.737361] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[564.856332] [114/131] (457s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[564.948599] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[568.579632] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.636s)
[569.748152] [115/131] (452s left) gem_exec_schedule (lateslice)
[569.825187] Starting subtest: lateslice
[569.827589] Starting dynamic subtest: rcs0
[569.836579] Dynamic subtest rcs0: SUCCESS (0.023s)
[569.851272] Starting dynamic subtest: bcs0
[569.857784] Dynamic subtest bcs0: SUCCESS (0.020s)
[569.872000] Starting dynamic subtest: vcs0
[569.880866] Dynamic subtest vcs0: SUCCESS (0.022s)
[569.892313] Starting dynamic subtest: vcs1
[569.907594] Dynamic subtest vcs1: SUCCESS (0.026s)
[569.916617] Starting dynamic subtest: vecs0
[569.927258] Dynamic subtest vecs0: SUCCESS (0.019s)
[569.937780] Starting dynamic subtest: ccs0
[569.944076] Dynamic subtest ccs0: SUCCESS (0.016s)
[569.946408] Subtest lateslice: SUCCESS (0.131s)
[571.165612] [116/131] (451s left) kms_vblank (query-idle-hang)
[571.265532] Starting subtest: query-idle-hang
[571.267463] Starting dynamic subtest: pipe-A-eDP-1
[598.820544] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.560s)
[598.834542] Starting dynamic subtest: pipe-D-eDP-1
[623.844898] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.028s)
[623.846830] Subtest query-idle-hang: SUCCESS (52.592s)
[624.728408] [117/131] (397s left) syncobj_wait (reset-multiple-signaled)
[624.795989] Starting subtest: reset-multiple-signaled
[624.798489] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[624.936633] [118/131] (397s left) kms_flip_event_leak (basic)
[625.020416] Starting subtest: basic
[625.022356] Starting dynamic subtest: pipe-A-eDP-1
[625.450069] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.429s)
[625.464797] Starting dynamic subtest: pipe-B-eDP-1
[626.580127] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s)
[626.589552] Starting dynamic subtest: pipe-C-eDP-1
[627.679806] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.101s)
[627.691194] Starting dynamic subtest: pipe-D-eDP-1
[628.774834] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.091s)
[628.776947] Subtest basic: SUCCESS (3.753s)
[629.622039] [119/131] (393s left) gem_pwrite_snooped
[629.772094] [120/131] (393s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[629.836680] Starting subtest: yf-tiled-ccs-to-y-tiled
[629.841255] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[630.051675] [121/131] (392s left) gem_ctx_shared (q-independent)
[630.114136] Starting subtest: Q-independent
[630.116631] Starting dynamic subtest: rcs0
[630.184054] Dynamic subtest rcs0: SUCCESS (0.070s)
[630.195853] Starting dynamic subtest: vcs0
[630.222671] Dynamic subtest vcs0: SUCCESS (0.038s)
[630.232169] Starting dynamic subtest: vcs1
[630.258875] Dynamic subtest vcs1: SUCCESS (0.036s)
[630.268238] Starting dynamic subtest: vecs0
[630.297148] Dynamic subtest vecs0: SUCCESS (0.037s)
[630.307102] Starting dynamic subtest: ccs0
[630.336964] Dynamic subtest ccs0: SUCCESS (0.039s)
[630.339290] Subtest Q-independent: SUCCESS (0.224s)
[632.239460] [122/131] (390s left) prime_mmap (test_userptr)
[632.304683] Starting subtest: test_userptr
[632.307145] Starting dynamic subtest: test_userptr-smem
[632.309505] Dynamic subtest test_userptr-smem: SUCCESS (0.001s)
[632.311829] Subtest test_userptr: SUCCESS (0.006s)
[632.447002] [123/131] (390s left) kms_addfb_basic (bad-pitch-65536)
[632.506454] Starting subtest: bad-pitch-65536
[632.508667] Subtest bad-pitch-65536: SUCCESS (0.000s)
[632.664058] [124/131] (390s left) prime_self_import (basic-with_fd_dup)
[632.700796] Starting subtest: basic-with_fd_dup
[632.720158] Subtest basic-with_fd_dup: SUCCESS (0.022s)
[632.873428] [125/131] (390s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[632.956176] Starting subtest: primary-y-tiled-reflect-x-0
[633.016357] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[633.142719] [126/131] (389s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[633.241492] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[633.243450] Starting dynamic subtest: pipe-A-eDP-1
[633.262394] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[633.272918] Starting dynamic subtest: pipe-B-eDP-1
[633.290054] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[633.298712] Starting dynamic subtest: pipe-C-eDP-1
[633.315712] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[633.324270] Starting dynamic subtest: pipe-D-eDP-1
[633.342955] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[633.346358] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[635.530617] [127/131] (387s left) kms_addfb_basic (unused-modifier)
[635.602284] Starting subtest: unused-modifier
[635.604492] Subtest unused-modifier: SUCCESS (0.000s)
[635.791083] [128/131] (387s left) kms_vblank (wait-idle)
[635.887947] Starting subtest: wait-idle
[635.889768] Starting dynamic subtest: pipe-A-eDP-1
[637.660285] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.774s)
[637.673981] Starting dynamic subtest: pipe-D-eDP-1
[640.116165] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.451s)
[640.118487] Subtest wait-idle: SUCCESS (4.229s)
[640.965750] [129/131] (382s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[641.091613] Starting subtest: cursorA-vs-flipA-toggle
[652.252337] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.151s)
[653.136996] [130/131] (370s left) gen9_exec_parse (bb-start-far)
[653.211926] Subtest bb-start-far: SKIP (0.000s)
[653.302494] [131/131] (370s left) kms_addfb_basic (basic)
[653.363107] Starting subtest: basic
[653.365416] Subtest basic: SUCCESS (0.000s)
[653.532475] 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.