[63.520558] Initializing watchdogs
[63.520623]   /dev/watchdog0
[63.536235] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[63.541760] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.544971] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.546783] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[63.582411] Starting subtest: invalid-bad-pad
[63.583142] Subtest invalid-bad-pad: SUCCESS (0.000s)
[63.668540] [002/131] (960s left) tools_test (tools_test)
[63.702403] Starting subtest: tools_test
[63.774667] Subtest tools_test: SUCCESS (0.076s)
[63.853626] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[63.886166] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[63.923701] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[63.968371] Starting subtest: sync-unmap-cycles
[69.377945] Subtest sync-unmap-cycles: SUCCESS (5.373s)
[69.471182] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[69.560991] Starting subtest: stress-xrgb8888-ytiled
[76.663296] Subtest stress-xrgb8888-ytiled: SUCCESS (7.102s)
[76.798075] [006/131] (947s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[76.886791] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[76.887503] Starting dynamic subtest: pipe-A-HDMI-A-1
[76.890375] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[76.897119] Starting dynamic subtest: pipe-B-HDMI-A-1
[76.899883] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[76.906372] Starting dynamic subtest: pipe-C-HDMI-A-1
[76.909130] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[76.915445] Starting dynamic subtest: pipe-D-HDMI-A-1
[76.918209] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[76.919579] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[77.125217] [007/131] (947s left) api_intel_allocator (gem-pool)
[77.157908] Starting subtest: gem-pool
[77.163018] Subtest gem-pool: SUCCESS (0.005s)
[77.273175] [008/131] (947s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[77.359388] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[77.360747] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[77.466008] [009/131] (946s left) kms_atomic_interruptible (universal-setplane-primary)
[77.548688] Starting subtest: universal-setplane-primary
[77.550177] Starting dynamic subtest: pipe-A-HDMI-A-1
[83.792791] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.242s)
[83.793475] Subtest universal-setplane-primary: SUCCESS (6.244s)
[83.949741] [010/131] (940s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[84.041389] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[85.708095] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (1.667s)
[85.854530] [011/131] (938s left) gem_eio (in-flight-contexts-1us)
[85.895623] Starting subtest: in-flight-contexts-1us
[99.881814] Subtest in-flight-contexts-1us: SUCCESS (13.984s)
[100.019175] [012/131] (924s left) gem_exec_balancer (semaphore)
[100.060211] Starting subtest: semaphore
[101.332148] Subtest semaphore: SUCCESS (1.272s)
[101.538248] [013/131] (922s left) kms_chamelium_hpd (hdmi-hpd)
[101.679118] Subtest hdmi-hpd: SKIP (0.000s)
[101.776169] [014/131] (922s left) kms_flip (wf_vblank-ts-check)
[101.863369] Starting subtest: wf_vblank-ts-check
[101.865172] Starting dynamic subtest: A-HDMI-A1
[109.711135] Dynamic subtest A-HDMI-A1: SUCCESS (7.827s)
[109.716811] Starting dynamic subtest: B-HDMI-A1
[117.517927] Dynamic subtest B-HDMI-A1: SUCCESS (7.797s)
[117.523404] Starting dynamic subtest: C-HDMI-A1
[125.315094] Dynamic subtest C-HDMI-A1: SUCCESS (7.796s)
[125.320598] Starting dynamic subtest: D-HDMI-A1
[133.101659] Dynamic subtest D-HDMI-A1: SUCCESS (7.809s)
[133.102351] Subtest wf_vblank-ts-check: SUCCESS (31.237s)
[133.278487] [015/131] (891s left) gem_exec_reloc (basic-gtt)
[133.316052] Starting subtest: basic-gtt
[133.323202] Subtest basic-gtt: SUCCESS (0.007s)
[133.449114] [016/131] (891s left) gem_exec_schedule (reorder-wide)
[133.616345] Starting subtest: reorder-wide
[133.617423] Starting dynamic subtest: rcs0
[133.715707] Dynamic subtest rcs0: SUCCESS (0.100s)
[133.725283] Starting dynamic subtest: bcs0
[133.787754] Dynamic subtest bcs0: SUCCESS (0.071s)
[133.796985] Starting dynamic subtest: vcs0
[133.859576] Dynamic subtest vcs0: SUCCESS (0.071s)
[133.871229] Starting dynamic subtest: vcs1
[133.930173] Dynamic subtest vcs1: SUCCESS (0.070s)
[133.939674] Starting dynamic subtest: vecs0
[134.001532] Dynamic subtest vecs0: SUCCESS (0.071s)
[134.002459] Subtest reorder-wide: SUCCESS (0.386s)
[134.194888] [FACT gem_exec_schedule (reorder-wide)] new: kernel.kmod_is_loaded.vgem: true
[134.196529] [017/131] (890s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[134.279720] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[134.280451] Starting dynamic subtest: pipe-A-HDMI-A-1
[134.418016] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.135s)
[134.424299] Starting dynamic subtest: pipe-B-HDMI-A-1
[134.523496] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.104s)
[134.529637] Starting dynamic subtest: pipe-C-HDMI-A-1
[134.633078] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.108s)
[134.639120] Starting dynamic subtest: pipe-D-HDMI-A-1
[134.739967] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.106s)
[134.740665] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.458s)
[135.017042] [018/131] (889s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[135.106488] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[135.107878] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[135.229716] [019/131] (889s left) perf (polling)
[135.330721] Starting subtest: polling
[135.331396] Starting dynamic subtest: 0-rcs0
[145.395680] Dynamic subtest 0-rcs0: SUCCESS (10.030s)
[145.396743] Subtest polling: SUCCESS (10.031s)
[145.457679] [020/131] (879s left) gem_userptr_blits (probe)
[145.518205] Starting subtest: probe
[145.624312] Subtest probe: SUCCESS (0.106s)
[145.748369] [021/131] (879s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[145.842985] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[145.844365] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[145.958314] [022/131] (878s left) gem_mmap_offset (pf-nonblock)
[145.990731] Starting subtest: pf-nonblock
[145.994989] Subtest pf-nonblock: SUCCESS (0.005s)
[146.122944] [023/131] (878s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[146.204728] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[146.205406] Starting dynamic subtest: pipe-A-HDMI-A-1
[146.212604] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[146.218637] Starting dynamic subtest: pipe-B-HDMI-A-1
[146.225819] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[146.231796] Starting dynamic subtest: pipe-C-HDMI-A-1
[146.238959] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[146.244752] Starting dynamic subtest: pipe-D-HDMI-A-1
[146.252107] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[146.253405] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[146.441332] [024/131] (878s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[146.532357] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[146.533774] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[146.647137] [025/131] (878s left) core_getstats (basic)
[146.678491] Starting subtest: basic
[146.679237] Subtest basic: SUCCESS (0.000s)
[146.761774] [026/131] (878s left) core_getclient (basic)
[146.793118] Starting subtest: basic
[146.793789] Subtest basic: SUCCESS (0.000s)
[146.880383] [027/131] (878s left) syncobj_timeline (multi-wait-all-available-submitted)
[146.912313] Starting subtest: multi-wait-all-available-submitted
[146.913028] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[146.994712] [028/131] (878s left) gem_exec_reloc (basic-write-wc)
[147.030930] Starting subtest: basic-write-wc
[147.036988] Subtest basic-write-wc: SUCCESS (0.006s)
[147.208121] [029/131] (877s left) kms_invalid_mode (clock-too-high)
[147.291517] Starting subtest: clock-too-high
[147.292258] Starting dynamic subtest: pipe-A-HDMI-A-1
[147.352895] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.061s)
[147.362803] Starting dynamic subtest: pipe-B-HDMI-A-1
[147.366488] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.011s)
[147.373606] Starting dynamic subtest: pipe-C-HDMI-A-1
[147.377420] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.009s)
[147.383548] Starting dynamic subtest: pipe-D-HDMI-A-1
[147.387211] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.009s)
[147.387888] Subtest clock-too-high: SUCCESS (0.096s)
[147.539812] [030/131] (877s left) gem_mmap_offset (bad-object)
[147.573215] Starting subtest: bad-object
[147.574687] Subtest bad-object: SUCCESS (0.002s)
[147.693589] [031/131] (877s left) syncobj_timeline (wait-all-delayed-signal)
[147.725209] Starting subtest: wait-all-delayed-signal
[147.827547] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[147.919439] [032/131] (877s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[148.013580] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[148.303061] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.289s)
[148.460420] [033/131] (876s left) gem_exec_suspend (basic-s3)
[148.500414] Starting subtest: basic-S3
[148.501102] Starting dynamic subtest: smem
[166.169922] Dynamic subtest smem: SUCCESS (3.056s)
[166.170814] Subtest basic-S3: SUCCESS (3.057s)
[173.402617] [034/131] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[173.497187] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[173.498537] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[173.624666] [035/131] (858s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[173.712192] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[173.713546] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[173.832191] [036/131] (858s left) kms_chamelium_frames (hdmi-crc-multiple)
[173.974859] Subtest hdmi-crc-multiple: SKIP (0.000s)
[174.061897] [037/131] (858s left) gem_exec_fence (syncobj-import)
[174.383737] Starting subtest: syncobj-import
[174.385959] Subtest syncobj-import: SUCCESS (0.002s)
[174.691581] [038/131] (857s left) kms_legacy_colorkey (basic)
[174.775289] Starting subtest: basic
[174.775973] Starting dynamic subtest: pipe-A
[174.819422] Dynamic subtest pipe-A: SUCCESS (0.044s)
[174.832038] Starting dynamic subtest: pipe-B
[174.832825] Dynamic subtest pipe-B: SUCCESS (0.001s)
[174.841948] Starting dynamic subtest: pipe-C
[174.842637] Dynamic subtest pipe-C: SUCCESS (0.001s)
[174.848880] Starting dynamic subtest: pipe-D
[174.849557] Dynamic subtest pipe-D: SUCCESS (0.001s)
[174.850216] Subtest basic: SUCCESS (0.050s)
[174.935173] [039/131] (857s left) gem_softpin (allocator-nopin-reserve)
[174.970057] Starting subtest: allocator-nopin-reserve
[175.048685] Subtest allocator-nopin-reserve: SUCCESS (0.078s)
[175.183198] [040/131] (857s left) perf_pmu (enable-race)
[175.216847] Starting subtest: enable-race
[175.217556] Starting dynamic subtest: rcs0
[187.811310] Dynamic subtest rcs0: SUCCESS (12.573s)
[187.823835] Starting dynamic subtest: bcs0
[200.391353] Dynamic subtest bcs0: SUCCESS (12.568s)
[200.404144] Starting dynamic subtest: vcs0
[212.936662] Dynamic subtest vcs0: SUCCESS (12.568s)
[212.943857] Starting dynamic subtest: vcs1
[225.530454] Dynamic subtest vcs1: SUCCESS (12.567s)
[225.540397] Starting dynamic subtest: vecs0
[238.075287] Dynamic subtest vecs0: SUCCESS (12.568s)
[238.075997] Subtest enable-race: SUCCESS (62.847s)
[238.160332] [041/131] (794s left) syncobj_timeline (signal-point-0)
[238.192453] Starting subtest: signal-point-0
[238.193137] Subtest signal-point-0: SUCCESS (0.001s)
[238.278809] [042/131] (794s left) gem_tiled_wb
[243.153579] [043/131] (789s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[243.240533] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[243.241276] Starting dynamic subtest: pipe-A-HDMI-A-1
[243.769261] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.525s)
[243.775959] Starting dynamic subtest: pipe-B-HDMI-A-1
[244.353513] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.583s)
[244.360140] Starting dynamic subtest: pipe-C-HDMI-A-1
[244.929146] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.574s)
[244.935787] Starting dynamic subtest: pipe-D-HDMI-A-1
[245.505333] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.575s)
[245.506166] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.263s)
[245.688474] [044/131] (787s left) gem_ctx_param (set-priority-invalid-size)
[245.721588] Starting subtest: set-priority-invalid-size
[245.722366] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[245.811188] [045/131] (787s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[245.901765] Starting subtest: plane-ctm3x4-lut1d
[245.919944] Starting dynamic subtest: pipe-A-HDMI-A-1
[246.086896] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.167s)
[246.253878] Starting dynamic subtest: pipe-B-HDMI-A-1
[246.394086] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.148s)
[246.535001] Starting dynamic subtest: pipe-C-HDMI-A-1
[246.675367] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.148s)
[246.795999] Starting dynamic subtest: pipe-D-HDMI-A-1
[246.938515] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.148s)
[247.003303] Subtest plane-ctm3x4-lut1d: SUCCESS (1.102s)
[247.123406] [046/131] (785s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[247.211699] Starting subtest: 2x-long-cursor-vs-flip-atomic
[247.214602] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[247.296774] [047/131] (785s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[247.388654] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[248.678362] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.290s)
[248.810026] [048/131] (784s left) kms_feature_discovery (display-1x)
[248.898603] Starting subtest: display-1x
[248.899321] Subtest display-1x: SUCCESS (0.000s)
[248.979939] [049/131] (784s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[249.074430] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[249.336381] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.262s)
[249.502762] [050/131] (783s left) i915_drm_fdinfo (most-busy-idle-check-all)
[249.538245] Starting subtest: most-busy-idle-check-all
[249.538944] Starting dynamic subtest: rcs0
[250.187339] Dynamic subtest rcs0: SUCCESS (0.648s)
[250.199129] Starting dynamic subtest: bcs0
[250.821612] Dynamic subtest bcs0: SUCCESS (0.633s)
[250.828464] Starting dynamic subtest: vcs0
[251.452973] Dynamic subtest vcs0: SUCCESS (0.629s)
[251.461860] Starting dynamic subtest: vcs1
[252.091232] Dynamic subtest vcs1: SUCCESS (0.636s)
[252.101426] Starting dynamic subtest: vecs0
[252.719932] Dynamic subtest vecs0: SUCCESS (0.628s)
[252.721052] Subtest most-busy-idle-check-all: SUCCESS (3.182s)
[252.808333] [051/131] (780s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[252.904263] Starting subtest: x-tiled-32bpp-rotate-270
[252.985335] Subtest x-tiled-32bpp-rotate-270: SKIP (0.080s)
[253.120763] [052/131] (780s left) gem_exec_schedule (u-submit-early-slice)
[253.165206] Starting subtest: u-submit-early-slice
[253.165912] Starting dynamic subtest: rcs0
[253.193714] Dynamic subtest rcs0: SUCCESS (0.028s)
[253.202566] Starting dynamic subtest: bcs0
[253.221472] Dynamic subtest bcs0: SUCCESS (0.027s)
[253.230205] Starting dynamic subtest: vcs0
[253.249439] Dynamic subtest vcs0: SUCCESS (0.027s)
[253.258143] Starting dynamic subtest: vcs1
[253.278029] Dynamic subtest vcs1: SUCCESS (0.028s)
[253.286850] Starting dynamic subtest: vecs0
[253.306846] Dynamic subtest vecs0: SUCCESS (0.028s)
[253.307590] Subtest u-submit-early-slice: SUCCESS (0.142s)
[253.625228] [053/131] (779s left) gem_pxp (regular-baseline-src-copy-readible)
[253.724085] Starting subtest: regular-baseline-src-copy-readible
[253.770619] Subtest regular-baseline-src-copy-readible: SUCCESS (0.048s)
[253.895503] [054/131] (779s left) gem_exec_balancer (full-late-pulse)
[253.937352] Starting subtest: full-late-pulse
[255.478717] Subtest full-late-pulse: SUCCESS (1.542s)
[255.686674] [055/131] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[255.777023] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[255.778364] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[255.897857] [056/131] (777s left) fbdev (read)
[255.940823] Starting subtest: read
[256.603995] Subtest read: SUCCESS (0.656s)
[256.669715] [057/131] (776s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[256.758280] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[256.759621] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[256.870784] [058/131] (776s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[256.956396] Starting subtest: multiplane-rotation-cropping-top
[282.718044] Subtest multiplane-rotation-cropping-top: SUCCESS (25.762s)
[282.871172] [059/131] (750s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[282.971571] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[282.972987] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[283.100987] [060/131] (750s left) i915_selftest (mock)
[284.126221] Starting subtest: mock
[284.132440] Starting dynamic subtest: sanitycheck
[284.830431] Dynamic subtest sanitycheck: SUCCESS (0.703s)
[284.841067] Starting dynamic subtest: shmem
[285.580325] Dynamic subtest shmem: SUCCESS (0.745s)
[285.590343] Starting dynamic subtest: fence
[293.672577] Dynamic subtest fence: SUCCESS (8.090s)
[293.681313] Starting dynamic subtest: scatterlist
[295.392372] Dynamic subtest scatterlist: SUCCESS (1.718s)
[295.400688] Starting dynamic subtest: syncmap
[298.372249] Dynamic subtest syncmap: SUCCESS (2.977s)
[298.382565] Starting dynamic subtest: uncore
[299.110261] Dynamic subtest uncore: SUCCESS (0.735s)
[299.124937] Starting dynamic subtest: ring
[299.844211] Dynamic subtest ring: SUCCESS (0.732s)
[299.854366] Starting dynamic subtest: engine
[300.576416] Dynamic subtest engine: SUCCESS (0.730s)
[300.586582] Starting dynamic subtest: timelines
[305.020370] Dynamic subtest timelines: SUCCESS (4.442s)
[305.028851] Starting dynamic subtest: requests
[309.172320] Dynamic subtest requests: SUCCESS (4.150s)
[309.179848] Starting dynamic subtest: objects
[310.014431] Dynamic subtest objects: SUCCESS (0.840s)
[310.024126] Starting dynamic subtest: phys
[310.862276] Dynamic subtest phys: SUCCESS (0.845s)
[310.872255] Starting dynamic subtest: dmabuf
[311.725312] Dynamic subtest dmabuf: SUCCESS (0.860s)
[311.734580] Starting dynamic subtest: vma
[319.130364] Dynamic subtest vma: SUCCESS (7.402s)
[319.138773] Starting dynamic subtest: evict
[320.846323] Dynamic subtest evict: SUCCESS (1.714s)
[320.854853] Starting dynamic subtest: gtt
[324.585165] Dynamic subtest gtt: SUCCESS (3.736s)
[324.595449] Starting dynamic subtest: hugepages
[325.582346] Dynamic subtest hugepages: SUCCESS (0.995s)
[325.590506] Starting dynamic subtest: memory_region
[328.945105] Dynamic subtest memory_region: SUCCESS (3.360s)
[328.945795] Subtest mock: SUCCESS (44.818s)
[328.975533] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[328.976305] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[328.980412] [061/131] (704s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[330.084142] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[330.141296] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[330.142745] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[330.145100] [062/131] (703s left) gem_render_copy_redux (normal)
[330.189796] Starting subtest: normal
[330.527558] Subtest normal: SUCCESS (0.330s)
[330.661773] [063/131] (702s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[330.700166] Starting subtest: basic-cpu-wc-noreloc
[330.703798] Subtest basic-cpu-wc-noreloc: SUCCESS (0.004s)
[330.849401] [064/131] (702s left) gem_ctx_param (invalid-set-no-zeromap)
[330.881759] Starting subtest: invalid-set-no-zeromap
[330.882466] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[330.966440] [065/131] (702s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[331.056192] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[331.057552] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[331.177265] [066/131] (702s left) i915_pm_rps (reset)
[331.215121] Starting subtest: reset
[335.752368] Subtest reset: SUCCESS (4.532s)
[335.890179] [067/131] (697s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[335.982035] Starting subtest: async-flip-with-page-flip-events-linear
[336.107788] Starting dynamic subtest: pipe-A-HDMI-A-1
[338.202824] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.086s)
[338.326027] Starting dynamic subtest: pipe-B-HDMI-A-1
[340.392491] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.065s)
[340.521380] Starting dynamic subtest: pipe-C-HDMI-A-1
[342.585525] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.063s)
[342.700568] Starting dynamic subtest: pipe-D-HDMI-A-1
[344.760783] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.060s)
[344.761517] Subtest async-flip-with-page-flip-events-linear: SUCCESS (8.771s)
[344.977702] [068/131] (688s left) perf_pmu (module-unload)
[345.022401] Starting subtest: module-unload
[347.833371] Subtest module-unload: FAIL (2.786s)
[347.856847] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[347.857605] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[347.859833] [069/131] (685s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[348.960379] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[348.962138] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[349.043173] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[349.044535] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[349.046793] [070/131] (684s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[349.082943] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[349.187517] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[349.279777] [071/131] (684s left) kms_cursor_crc (cursor-random-256x85)
[349.369419] Starting subtest: cursor-random-256x85
[349.384530] Starting dynamic subtest: pipe-A-HDMI-A-1
[350.629416] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.075s)
[350.639364] Starting dynamic subtest: pipe-D-HDMI-A-1
[352.460774] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.965s)
[352.461528] Subtest cursor-random-256x85: FAIL (3.092s)
[352.632955] [072/131] (681s left) kms_psr (psr-sprite-plane-move)
[352.726331] Subtest psr-sprite-plane-move: SKIP (0.000s)
[352.774629] [073/131] (681s left) kms_psr (fbc-pr-sprite-plane-onoff)
[352.859882] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[352.910737] [074/131] (681s left) kms_pm_rpm (pm-tiling)
[354.301127] Starting subtest: pm-tiling
[358.152636] Subtest pm-tiling: SUCCESS (3.851s)
[358.250249] [075/131] (675s left) gem_userptr_blits (invalid-null-pointer)
[358.292110] Starting subtest: invalid-null-pointer
[358.294697] Subtest invalid-null-pointer: SUCCESS (0.004s)
[358.441964] [076/131] (675s left) kms_content_protection (lic-type-1)
[358.530517] Starting subtest: lic-type-1
[358.542947] Subtest lic-type-1: SKIP (0.011s)
[358.666584] [077/131] (675s left) kms_atomic (plane-immutable-zpos)
[358.749626] Starting subtest: plane-immutable-zpos
[358.751347] Starting dynamic subtest: pipe-A-HDMI-A-1
[359.049949] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.299s)
[359.050612] Subtest plane-immutable-zpos: SUCCESS (0.301s)
[359.212154] [078/131] (674s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[359.297128] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[359.299892] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[359.374581] [079/131] (674s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[359.462644] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[359.463329] Starting dynamic subtest: pipe-A
[360.570412] Dynamic subtest pipe-A: SUCCESS (1.107s)
[360.579549] Starting dynamic subtest: pipe-B
[361.747004] Dynamic subtest pipe-B: SUCCESS (1.175s)
[361.755400] Starting dynamic subtest: pipe-C
[361.956870] Dynamic subtest pipe-C: SUCCESS (0.209s)
[361.966177] Starting dynamic subtest: pipe-D
[362.157341] Dynamic subtest pipe-D: SUCCESS (0.199s)
[362.158040] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.695s)
[362.342859] [080/131] (671s left) kms_psr (pr-sprite-mmap-cpu)
[362.435968] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[362.480132] [081/131] (671s left) gem_ctx_persistence (legacy-engines-cleanup)
[362.517624] Starting subtest: legacy-engines-cleanup
[362.518390] Starting dynamic subtest: render
[362.575374] Dynamic subtest render: SUCCESS (0.056s)
[362.595895] Starting dynamic subtest: bsd1
[362.638345] Dynamic subtest bsd1: SUCCESS (0.059s)
[362.657870] Starting dynamic subtest: bsd2
[362.687246] Dynamic subtest bsd2: SUCCESS (0.045s)
[362.705277] Starting dynamic subtest: blt
[362.733266] Dynamic subtest blt: SUCCESS (0.042s)
[362.751161] Starting dynamic subtest: vebox
[362.784373] Dynamic subtest vebox: SUCCESS (0.047s)
[362.788826] Subtest legacy-engines-cleanup: SUCCESS (0.268s)
[362.874234] [082/131] (671s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[362.959831] Starting subtest: cursor-tearing-framebuffer-change
[362.961590] Starting dynamic subtest: pipe-A-HDMI-A-1
[363.216211] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.254s)
[363.225881] Starting dynamic subtest: pipe-D-HDMI-A-1
[363.430014] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.212s)
[363.430848] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.471s)
[363.587741] [083/131] (670s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[363.676241] Starting subtest: 2x-cursor-vs-flip-atomic
[363.679592] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.003s)
[363.762676] [084/131] (670s left) kms_cursor_crc (cursor-random-32x10)
[363.849948] Starting subtest: cursor-random-32x10
[363.901269] Subtest cursor-random-32x10: SKIP (0.050s)
[364.016039] [085/131] (670s left) kms_psr (fbc-psr-primary-mmap-gtt)
[364.100316] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[364.145890] [086/131] (670s left) kms_big_fb (linear-8bpp-rotate-0)
[364.239513] Starting subtest: linear-8bpp-rotate-0
[365.291201] Subtest linear-8bpp-rotate-0: SUCCESS (1.051s)
[365.440691] [087/131] (669s left) gem_create (create-ext-cpu-access-sanity-check)
[365.589519] Starting subtest: create-ext-cpu-access-sanity-check
[365.608440] Subtest create-ext-cpu-access-sanity-check: SKIP (0.000s)
[365.674488] [088/131] (668s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[365.765477] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[366.860311] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (1.094s)
[367.016639] [089/131] (667s left) kms_pm_rpm (cursor-dpms)
[368.412264] Starting subtest: cursor-dpms
[380.436251] Subtest cursor-dpms: SUCCESS (12.025s)
[380.649122] [090/131] (654s left) gem_lmem_swapping (verify-random-ccs)
[380.687951] Subtest verify-random-ccs: SKIP (0.000s)
[380.727921] [091/131] (653s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[380.812888] Starting subtest: flip-vs-cursor-toggle
[389.248917] Subtest flip-vs-cursor-toggle: SUCCESS (8.435s)
[389.409634] [092/131] (645s left) gem_lmem_swapping (heavy-verify-multi)
[389.450651] Subtest heavy-verify-multi: SKIP (0.000s)
[389.497449] [093/131] (645s left) i915_pm_freq_api (freq-reset)
[389.533177] Subtest freq-reset: SKIP (0.000s)
[389.584719] [094/131] (645s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[389.679930] Starting subtest: y-tiled-64bpp-rotate-90
[389.730068] Subtest y-tiled-64bpp-rotate-90: SKIP (0.048s)
[389.865601] [095/131] (644s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[389.961203] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[389.962652] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[390.072093] [096/131] (644s left) kms_dirtyfb (default-dirtyfb-ioctl)
[390.158161] Starting subtest: default-dirtyfb-ioctl
[390.160455] Starting dynamic subtest: A-HDMI-A-1
[391.363522] Dynamic subtest A-HDMI-A-1: SUCCESS (1.204s)
[391.364253] Subtest default-dirtyfb-ioctl: SUCCESS (1.206s)
[391.481247] [097/131] (643s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[391.571676] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[391.572361] Starting dynamic subtest: pipe-A
[392.028831] Dynamic subtest pipe-A: SUCCESS (0.458s)
[392.039907] Starting dynamic subtest: pipe-B
[392.462366] Dynamic subtest pipe-B: SUCCESS (0.432s)
[392.472380] Starting dynamic subtest: pipe-C
[392.895819] Dynamic subtest pipe-C: SUCCESS (0.433s)
[392.905092] Starting dynamic subtest: pipe-D
[393.331512] Dynamic subtest pipe-D: SUCCESS (0.435s)
[393.332201] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (1.761s)
[393.526575] [098/131] (641s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[393.613020] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[393.615165] Starting dynamic subtest: pipe-A-valid-mode
[393.667075] Dynamic subtest pipe-A-valid-mode: SKIP (0.052s)
[393.668543] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.053s)
[393.798079] [099/131] (641s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[393.883699] Starting subtest: 2x-cursor-vs-flip-legacy
[393.886032] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[393.967358] [100/131] (641s left) gem_readwrite (write-bad-handle)
[394.001210] Starting subtest: write-bad-handle
[394.002635] Subtest write-bad-handle: SUCCESS (0.000s)
[394.114800] [101/131] (640s left) gem_reg_read (timestamp-monotonic)
[394.147040] Starting subtest: timestamp-monotonic
[398.912355] Subtest timestamp-monotonic: SUCCESS (4.732s)
[398.960614] [102/131] (636s left) kms_psr (fbc-psr2-cursor-plane-move)
[399.048337] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[399.088425] [103/131] (636s left) kms_plane_lowres (tiling-x)
[399.173713] Starting subtest: tiling-x
[399.175515] Starting dynamic subtest: pipe-A-HDMI-A-1
[406.155169] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.981s)
[406.212128] Starting dynamic subtest: pipe-B-HDMI-A-1
[413.040229] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.835s)
[413.116679] Starting dynamic subtest: pipe-C-HDMI-A-1
[419.903398] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.796s)
[419.962609] Starting dynamic subtest: pipe-D-HDMI-A-1
[426.795060] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (6.840s)
[426.861156] Subtest tiling-x: SUCCESS (27.689s)
[427.028387] [104/131] (608s left) kms_force_connector_basic (force-edid)
[427.160304] Starting subtest: force-edid
[427.307469] Subtest force-edid: SUCCESS (0.147s)
[427.476198] [105/131] (607s left) kms_getfb (getfb-handle-zero)
[427.560769] Starting subtest: getfb-handle-zero
[427.561502] Subtest getfb-handle-zero: SUCCESS (0.000s)
[427.661006] [106/131] (607s left) perf (missing-sample-flags)
[427.748470] Starting subtest: missing-sample-flags
[427.749156] Subtest missing-sample-flags: SUCCESS (0.001s)
[427.791509] [107/131] (607s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[427.880727] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[427.882046] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[427.999962] [108/131] (607s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[428.088485] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[428.089809] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[428.208567] [109/131] (607s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[428.300976] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[428.302396] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[428.416154] [110/131] (607s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[428.510719] Starting subtest: 4-tiled-8bpp-rotate-180
[428.512091] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[428.624650] [111/131] (606s left) gem_exec_fence (syncobj-timeline-repeat)
[429.103113] Starting subtest: syncobj-timeline-repeat
[429.433619] Subtest syncobj-timeline-repeat: SUCCESS (0.331s)
[429.626606] [112/131] (605s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[429.717566] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[429.718887] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[429.833862] [113/131] (605s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[429.866940] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[429.867631] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[429.956649] [114/131] (605s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[430.048957] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[431.275506] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (1.227s)
[431.433491] [115/131] (604s left) gem_exec_schedule (lateslice)
[431.475039] Starting subtest: lateslice
[431.475752] Starting dynamic subtest: rcs0
[431.491835] Dynamic subtest rcs0: SUCCESS (0.016s)
[431.500644] Starting dynamic subtest: bcs0
[431.506661] Dynamic subtest bcs0: SUCCESS (0.014s)
[431.515425] Starting dynamic subtest: vcs0
[431.521757] Dynamic subtest vcs0: SUCCESS (0.014s)
[431.530602] Starting dynamic subtest: vcs1
[431.540735] Dynamic subtest vcs1: SUCCESS (0.018s)
[431.549852] Starting dynamic subtest: vecs0
[431.559709] Dynamic subtest vecs0: SUCCESS (0.018s)
[431.560448] Subtest lateslice: SUCCESS (0.085s)
[431.883823] [116/131] (603s left) kms_vblank (query-idle-hang)
[431.970596] Starting subtest: query-idle-hang
[431.972367] Starting dynamic subtest: pipe-A-HDMI-A-1
[446.369669] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.398s)
[446.380552] Starting dynamic subtest: pipe-D-HDMI-A-1
[460.182884] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.808s)
[460.183671] Subtest query-idle-hang: SUCCESS (28.213s)
[460.372661] [117/131] (575s left) syncobj_wait (reset-multiple-signaled)
[460.408554] Starting subtest: reset-multiple-signaled
[460.409280] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[460.498071] [118/131] (575s left) kms_flip_event_leak (basic)
[460.585240] Starting subtest: basic
[460.587462] Starting dynamic subtest: pipe-A-HDMI-A-1
[460.766487] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.179s)
[460.775092] Starting dynamic subtest: pipe-B-HDMI-A-1
[460.922907] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.154s)
[460.932606] Starting dynamic subtest: pipe-C-HDMI-A-1
[461.075550] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.151s)
[461.084619] Starting dynamic subtest: pipe-D-HDMI-A-1
[461.220593] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.144s)
[461.221356] Subtest basic: SUCCESS (0.636s)
[461.373023] [119/131] (574s left) gem_pwrite_snooped
[461.547587] [120/131] (574s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[461.584911] Starting subtest: yf-tiled-ccs-to-y-tiled
[461.585640] Starting dynamic subtest: smem
[461.686315] Dynamic subtest smem: SUCCESS (0.101s)
[461.687028] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.102s)
[461.889544] [121/131] (574s left) gem_ctx_shared (q-independent)
[461.929982] Starting subtest: Q-independent
[461.930660] Starting dynamic subtest: rcs0
[461.950906] Dynamic subtest rcs0: SUCCESS (0.022s)
[461.960889] Starting dynamic subtest: bcs0
[461.970933] Dynamic subtest bcs0: SUCCESS (0.019s)
[461.980458] Starting dynamic subtest: vcs0
[461.993355] Dynamic subtest vcs0: SUCCESS (0.021s)
[462.001322] Starting dynamic subtest: vcs1
[462.013032] Dynamic subtest vcs1: SUCCESS (0.019s)
[462.021794] Starting dynamic subtest: vecs0
[462.032303] Dynamic subtest vecs0: SUCCESS (0.018s)
[462.033116] Subtest Q-independent: SUCCESS (0.104s)
[462.239679] [122/131] (573s left) prime_mmap (test_userptr)
[462.271850] Starting subtest: test_userptr
[462.272804] Starting dynamic subtest: test_userptr-smem
[462.273537] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[462.274221] Subtest test_userptr: SUCCESS (0.002s)
[462.380068] [123/131] (573s left) kms_addfb_basic (bad-pitch-65536)
[462.411630] Starting subtest: bad-pitch-65536
[462.412360] Subtest bad-pitch-65536: SUCCESS (0.000s)
[462.598594] [124/131] (573s left) prime_self_import (basic-with_fd_dup)
[462.629751] Starting subtest: basic-with_fd_dup
[462.632458] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[462.746819] [125/131] (573s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[462.831765] Starting subtest: primary-y-tiled-reflect-x-0
[467.735537] Subtest primary-y-tiled-reflect-x-0: SUCCESS (4.903s)
[467.953562] [126/131] (568s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[468.040678] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[468.041393] Starting dynamic subtest: pipe-A-HDMI-A-1
[468.048076] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[468.055567] Starting dynamic subtest: pipe-B-HDMI-A-1
[468.062256] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[468.069493] Starting dynamic subtest: pipe-C-HDMI-A-1
[468.076140] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[468.083508] Starting dynamic subtest: pipe-D-HDMI-A-1
[468.090156] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[468.091557] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[468.287809] [127/131] (567s left) kms_addfb_basic (unused-modifier)
[468.321246] Starting subtest: unused-modifier
[468.321923] Subtest unused-modifier: SUCCESS (0.000s)
[468.509513] [128/131] (567s left) kms_vblank (wait-idle)
[468.593745] Starting subtest: wait-idle
[468.595509] Starting dynamic subtest: pipe-A-HDMI-A-1
[469.774900] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.180s)
[469.785545] Starting dynamic subtest: pipe-D-HDMI-A-1
[470.935439] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.157s)
[470.936182] Subtest wait-idle: SUCCESS (2.343s)
[471.111338] [129/131] (565s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[471.201795] Starting subtest: cursorA-vs-flipA-toggle
[482.058054] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.856s)
[482.205852] [130/131] (554s left) gen9_exec_parse (bb-start-far)
[482.247842] Subtest bb-start-far: SKIP (0.000s)
[482.292869] [131/131] (554s left) kms_addfb_basic (basic)
[482.326273] Starting subtest: basic
[482.326975] Subtest basic: SUCCESS (0.000s)
[482.491999] 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.