[44.249158] Initializing watchdogs
[44.249221]   /dev/watchdog0
[44.263920] [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]
[44.269457] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[44.271905] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[44.273752] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[44.316469] Starting subtest: invalid-bad-pad
[44.317209] Subtest invalid-bad-pad: SUCCESS (0.000s)
[44.399757] [002/131] (960s left) tools_test (tools_test)
[44.434016] Starting subtest: tools_test
[44.507719] Subtest tools_test: SUCCESS (0.078s)
[44.580195] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[44.612282] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[44.645334] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[44.690583] Starting subtest: sync-unmap-cycles
[50.216580] Subtest sync-unmap-cycles: SUCCESS (5.370s)
[50.329867] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[50.422207] Starting subtest: stress-xrgb8888-ytiled
[57.830769] Subtest stress-xrgb8888-ytiled: SUCCESS (7.291s)
[57.972021] [006/131] (946s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[58.060556] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[58.062068] Starting dynamic subtest: pipe-A-HDMI-A-1
[58.064802] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[58.070149] Starting dynamic subtest: pipe-B-HDMI-A-1
[58.072956] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[58.078227] Starting dynamic subtest: pipe-C-HDMI-A-1
[58.080947] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[58.086257] Starting dynamic subtest: pipe-D-HDMI-A-1
[58.089019] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[58.090370] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[58.303612] [007/131] (946s left) api_intel_allocator (gem-pool)
[58.336297] Starting subtest: gem-pool
[58.341362] Subtest gem-pool: SUCCESS (0.005s)
[58.476885] [008/131] (946s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[58.564563] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[58.565971] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[58.678760] [009/131] (946s left) kms_atomic_interruptible (universal-setplane-primary)
[58.764326] Starting subtest: universal-setplane-primary
[58.765897] Starting dynamic subtest: pipe-A-HDMI-A-1
[65.012013] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.211s)
[65.012726] Subtest universal-setplane-primary: SUCCESS (6.212s)
[65.166739] [010/131] (939s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[65.263551] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[66.932916] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (1.664s)
[67.346753] [011/131] (937s left) gem_eio (in-flight-contexts-1us)
[67.501641] Starting subtest: in-flight-contexts-1us
[80.871745] Subtest in-flight-contexts-1us: SUCCESS (13.352s)
[81.061294] [012/131] (924s left) gem_exec_balancer (semaphore)
[81.101164] Starting subtest: semaphore
[82.381695] Subtest semaphore: SUCCESS (1.279s)
[82.588147] [013/131] (922s left) kms_chamelium_hpd (hdmi-hpd)
[82.723696] Subtest hdmi-hpd: SKIP (0.000s)
[82.806788] [014/131] (922s left) kms_flip (wf_vblank-ts-check)
[82.895395] Starting subtest: wf_vblank-ts-check
[82.897887] Starting dynamic subtest: A-HDMI-A1
[90.723611] Dynamic subtest A-HDMI-A1: SUCCESS (7.820s)
[90.732984] Starting dynamic subtest: B-HDMI-A1
[98.550009] Dynamic subtest B-HDMI-A1: SUCCESS (7.795s)
[98.556042] Starting dynamic subtest: C-HDMI-A1
[106.342231] Dynamic subtest C-HDMI-A1: SUCCESS (7.788s)
[106.348245] Starting dynamic subtest: D-HDMI-A1
[114.119500] Dynamic subtest D-HDMI-A1: SUCCESS (7.797s)
[114.120202] Subtest wf_vblank-ts-check: SUCCESS (31.210s)
[114.318550] [015/131] (890s left) gem_exec_reloc (basic-gtt)
[114.355742] Starting subtest: basic-gtt
[114.362304] Subtest basic-gtt: SUCCESS (0.007s)
[114.493726] [016/131] (890s left) gem_exec_schedule (reorder-wide)
[114.653980] Starting subtest: reorder-wide
[114.655288] Starting dynamic subtest: rcs0
[114.752319] Dynamic subtest rcs0: SUCCESS (0.101s)
[114.762151] Starting dynamic subtest: bcs0
[114.825264] Dynamic subtest bcs0: SUCCESS (0.072s)
[114.835780] Starting dynamic subtest: vcs0
[114.898143] Dynamic subtest vcs0: SUCCESS (0.072s)
[114.908205] Starting dynamic subtest: vcs1
[114.971406] Dynamic subtest vcs1: SUCCESS (0.071s)
[114.980564] Starting dynamic subtest: vecs0
[115.042252] Dynamic subtest vecs0: SUCCESS (0.073s)
[115.043314] Subtest reorder-wide: SUCCESS (0.392s)
[115.239198] [FACT gem_exec_schedule (reorder-wide)] new: kernel.kmod_is_loaded.vgem: true
[115.240758] [017/131] (890s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[115.323593] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[115.325046] Starting dynamic subtest: pipe-A-HDMI-A-1
[115.464802] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.137s)
[115.473207] Starting dynamic subtest: pipe-B-HDMI-A-1
[115.575632] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.109s)
[115.581977] Starting dynamic subtest: pipe-C-HDMI-A-1
[115.681266] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.105s)
[115.687641] Starting dynamic subtest: pipe-D-HDMI-A-1
[115.788446] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.106s)
[115.789159] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.462s)
[116.077957] [018/131] (889s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[116.167372] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[116.168702] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[116.273978] [019/131] (889s left) perf (polling)
[116.374423] Starting subtest: polling
[116.375096] Starting dynamic subtest: 0-rcs0
[126.419626] Dynamic subtest 0-rcs0: SUCCESS (10.009s)
[126.420572] Subtest polling: SUCCESS (10.009s)
[126.472748] [020/131] (879s left) gem_userptr_blits (probe)
[126.536664] Starting subtest: probe
[126.644510] Subtest probe: SUCCESS (0.107s)
[126.795626] [021/131] (878s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[126.889518] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[126.890939] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[127.002596] [022/131] (878s left) gem_mmap_offset (pf-nonblock)
[127.034701] Starting subtest: pf-nonblock
[127.039271] Subtest pf-nonblock: SUCCESS (0.005s)
[127.177649] [023/131] (878s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[127.259742] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[127.261278] Starting dynamic subtest: pipe-A-HDMI-A-1
[127.268765] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[127.275152] Starting dynamic subtest: pipe-B-HDMI-A-1
[127.282752] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[127.289062] Starting dynamic subtest: pipe-C-HDMI-A-1
[127.296506] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[127.302585] Starting dynamic subtest: pipe-D-HDMI-A-1
[127.310212] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[127.311556] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[127.504985] [024/131] (878s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[127.594636] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[127.596034] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[127.704599] [025/131] (878s left) core_getstats (basic)
[127.736304] Starting subtest: basic
[127.737035] Subtest basic: SUCCESS (0.000s)
[127.818711] [026/131] (877s left) core_getclient (basic)
[127.850283] Starting subtest: basic
[127.851037] Subtest basic: SUCCESS (0.000s)
[127.938011] [027/131] (877s left) syncobj_timeline (multi-wait-all-available-submitted)
[127.970699] Starting subtest: multi-wait-all-available-submitted
[127.971374] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[128.062212] [028/131] (877s left) gem_exec_reloc (basic-write-wc)
[128.098253] Starting subtest: basic-write-wc
[128.103521] Subtest basic-write-wc: SUCCESS (0.005s)
[128.237015] [029/131] (877s left) kms_invalid_mode (clock-too-high)
[128.321285] Starting subtest: clock-too-high
[128.322080] Starting dynamic subtest: pipe-A-HDMI-A-1
[128.385698] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.064s)
[128.394133] Starting dynamic subtest: pipe-B-HDMI-A-1
[128.399966] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.012s)
[128.408813] Starting dynamic subtest: pipe-C-HDMI-A-1
[128.414214] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.012s)
[128.420542] Starting dynamic subtest: pipe-D-HDMI-A-1
[128.423420] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.008s)
[128.424126] Subtest clock-too-high: SUCCESS (0.103s)
[128.602112] [030/131] (877s left) gem_mmap_offset (bad-object)
[128.635005] Starting subtest: bad-object
[128.636556] Subtest bad-object: SUCCESS (0.001s)
[128.763116] [031/131] (877s left) syncobj_timeline (wait-all-delayed-signal)
[128.794714] Starting subtest: wait-all-delayed-signal
[128.897078] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[128.985097] [032/131] (877s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[129.076955] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[129.388172] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.311s)
[129.546087] [033/131] (876s left) gem_exec_suspend (basic-s3)
[129.585956] Starting subtest: basic-S3
[129.586695] Starting dynamic subtest: smem
[146.731671] Dynamic subtest smem: SUCCESS (3.020s)
[146.732406] Subtest basic-S3: SUCCESS (3.021s)
[156.003688] [034/131] (859s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[156.107271] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[156.108687] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[156.242910] [035/131] (858s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[156.332682] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[156.334225] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[156.449744] [036/131] (858s left) kms_chamelium_frames (hdmi-crc-multiple)
[156.591507] Subtest hdmi-crc-multiple: SKIP (0.000s)
[156.683966] [037/131] (858s left) gem_exec_fence (syncobj-import)
[157.001137] Starting subtest: syncobj-import
[157.003304] Subtest syncobj-import: SUCCESS (0.002s)
[157.324452] [038/131] (858s left) kms_legacy_colorkey (basic)
[157.409473] Starting subtest: basic
[157.410178] Starting dynamic subtest: pipe-A
[157.459089] Dynamic subtest pipe-A: SUCCESS (0.048s)
[157.474814] Starting dynamic subtest: pipe-B
[157.475674] Dynamic subtest pipe-B: SUCCESS (0.001s)
[157.484704] Starting dynamic subtest: pipe-C
[157.485452] Dynamic subtest pipe-C: SUCCESS (0.001s)
[157.492383] Starting dynamic subtest: pipe-D
[157.493099] Dynamic subtest pipe-D: SUCCESS (0.001s)
[157.493805] Subtest basic: SUCCESS (0.055s)
[157.557049] [039/131] (857s left) gem_softpin (allocator-nopin-reserve)
[157.595478] Starting subtest: allocator-nopin-reserve
[157.677529] Subtest allocator-nopin-reserve: SUCCESS (0.079s)
[157.802231] [040/131] (857s left) perf_pmu (enable-race)
[157.839016] Starting subtest: enable-race
[157.839747] Starting dynamic subtest: rcs0
[170.484466] Dynamic subtest rcs0: SUCCESS (12.432s)
[170.494429] Starting dynamic subtest: bcs0
[183.054266] Dynamic subtest bcs0: SUCCESS (12.528s)
[183.067930] Starting dynamic subtest: vcs0
[195.621279] Dynamic subtest vcs0: SUCCESS (12.564s)
[195.631609] Starting dynamic subtest: vcs1
[208.194371] Dynamic subtest vcs1: SUCCESS (12.563s)
[208.203951] Starting dynamic subtest: vecs0
[220.749717] Dynamic subtest vecs0: SUCCESS (12.572s)
[220.750448] Subtest enable-race: SUCCESS (62.662s)
[220.847510] [041/131] (794s left) syncobj_timeline (signal-point-0)
[220.881757] Starting subtest: signal-point-0
[220.882516] Subtest signal-point-0: SUCCESS (0.000s)
[220.966557] [042/131] (794s left) gem_tiled_wb
[225.370252] [043/131] (790s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[225.457453] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[225.459042] Starting dynamic subtest: pipe-A-HDMI-A-1
[225.984848] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.524s)
[225.991906] Starting dynamic subtest: pipe-B-HDMI-A-1
[226.561933] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.575s)
[226.569669] Starting dynamic subtest: pipe-C-HDMI-A-1
[227.147873] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.584s)
[227.156149] Starting dynamic subtest: pipe-D-HDMI-A-1
[227.733487] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.584s)
[227.734442] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.273s)
[227.915468] [044/131] (787s left) gem_ctx_param (set-priority-invalid-size)
[227.948244] Starting subtest: set-priority-invalid-size
[227.948914] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[228.036159] [045/131] (787s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[228.125407] Starting subtest: plane-ctm3x4-lut1d
[228.139552] Starting dynamic subtest: pipe-A-HDMI-A-1
[228.306336] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.166s)
[228.460937] Starting dynamic subtest: pipe-B-HDMI-A-1
[228.602845] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.148s)
[228.741398] Starting dynamic subtest: pipe-C-HDMI-A-1
[228.881489] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.148s)
[229.003168] Starting dynamic subtest: pipe-D-HDMI-A-1
[229.152556] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.156s)
[229.216777] Subtest plane-ctm3x4-lut1d: SUCCESS (1.091s)
[229.334783] [046/131] (786s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[229.423422] Starting subtest: 2x-long-cursor-vs-flip-atomic
[229.425859] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[229.515960] [047/131] (786s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[229.604430] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[230.886554] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.282s)
[231.011592] [048/131] (784s left) kms_feature_discovery (display-1x)
[231.100413] Starting subtest: display-1x
[231.101108] Subtest display-1x: SUCCESS (0.000s)
[231.187985] [049/131] (784s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[231.283234] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[231.536190] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.253s)
[231.694649] [050/131] (784s left) i915_drm_fdinfo (most-busy-idle-check-all)
[231.729243] Starting subtest: most-busy-idle-check-all
[231.729985] Starting dynamic subtest: rcs0
[232.377145] Dynamic subtest rcs0: SUCCESS (0.647s)
[232.387538] Starting dynamic subtest: bcs0
[233.019211] Dynamic subtest bcs0: SUCCESS (0.640s)
[233.029957] Starting dynamic subtest: vcs0
[233.663051] Dynamic subtest vcs0: SUCCESS (0.642s)
[233.675454] Starting dynamic subtest: vcs1
[234.302595] Dynamic subtest vcs1: SUCCESS (0.637s)
[234.312713] Starting dynamic subtest: vecs0
[234.939917] Dynamic subtest vecs0: SUCCESS (0.635s)
[234.940965] Subtest most-busy-idle-check-all: SUCCESS (3.209s)
[235.025939] [051/131] (780s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[235.122185] Starting subtest: x-tiled-32bpp-rotate-270
[235.195277] Subtest x-tiled-32bpp-rotate-270: SKIP (0.072s)
[235.330819] [052/131] (780s left) gem_exec_schedule (u-submit-early-slice)
[235.375033] Starting subtest: u-submit-early-slice
[235.375758] Starting dynamic subtest: rcs0
[235.405532] Dynamic subtest rcs0: SUCCESS (0.030s)
[235.412579] Starting dynamic subtest: bcs0
[235.434500] Dynamic subtest bcs0: SUCCESS (0.028s)
[235.441531] Starting dynamic subtest: vcs0
[235.460472] Dynamic subtest vcs0: SUCCESS (0.025s)
[235.467815] Starting dynamic subtest: vcs1
[235.486742] Dynamic subtest vcs1: SUCCESS (0.026s)
[235.494399] Starting dynamic subtest: vecs0
[235.514784] Dynamic subtest vecs0: SUCCESS (0.027s)
[235.515512] Subtest u-submit-early-slice: SUCCESS (0.140s)
[235.831632] [053/131] (780s left) gem_pxp (regular-baseline-src-copy-readible)
[235.932612] Starting subtest: regular-baseline-src-copy-readible
[235.979296] Subtest regular-baseline-src-copy-readible: SUCCESS (0.048s)
[236.114530] [054/131] (779s left) gem_exec_balancer (full-late-pulse)
[236.154753] Starting subtest: full-late-pulse
[237.732694] Subtest full-late-pulse: SUCCESS (1.577s)
[237.946445] [055/131] (778s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[238.036128] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[238.037469] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[238.149680] [056/131] (777s left) fbdev (read)
[238.192335] Starting subtest: read
[238.855965] Subtest read: SUCCESS (0.655s)
[238.924016] [057/131] (777s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[239.010989] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[239.012303] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[239.124086] [058/131] (777s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[239.208759] Starting subtest: multiplane-rotation-cropping-top
[264.959312] Subtest multiplane-rotation-cropping-top: SUCCESS (25.755s)
[265.090131] [059/131] (751s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[265.188289] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[265.189664] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[265.316665] [060/131] (750s left) i915_selftest (mock)
[266.345354] Starting subtest: mock
[266.349578] Starting dynamic subtest: sanitycheck
[267.074060] Dynamic subtest sanitycheck: SUCCESS (0.721s)
[267.083917] Starting dynamic subtest: shmem
[267.818442] Dynamic subtest shmem: SUCCESS (0.743s)
[267.828399] Starting dynamic subtest: fence
[275.110399] Dynamic subtest fence: SUCCESS (7.290s)
[275.120252] Starting dynamic subtest: scatterlist
[276.841393] Dynamic subtest scatterlist: SUCCESS (1.728s)
[276.850038] Starting dynamic subtest: syncmap
[279.779249] Dynamic subtest syncmap: SUCCESS (2.936s)
[279.788153] Starting dynamic subtest: uncore
[280.518420] Dynamic subtest uncore: SUCCESS (0.737s)
[280.533279] Starting dynamic subtest: ring
[281.257412] Dynamic subtest ring: SUCCESS (0.737s)
[281.267592] Starting dynamic subtest: engine
[281.976369] Dynamic subtest engine: SUCCESS (0.717s)
[281.986516] Starting dynamic subtest: timelines
[286.404376] Dynamic subtest timelines: SUCCESS (4.425s)
[286.412896] Starting dynamic subtest: requests
[289.231169] Dynamic subtest requests: SUCCESS (2.824s)
[289.237201] Starting dynamic subtest: objects
[290.088412] Dynamic subtest objects: SUCCESS (0.855s)
[290.099552] Starting dynamic subtest: phys
[290.966217] Dynamic subtest phys: SUCCESS (0.875s)
[290.975627] Starting dynamic subtest: dmabuf
[291.821239] Dynamic subtest dmabuf: SUCCESS (0.853s)
[291.831676] Starting dynamic subtest: vma
[299.232455] Dynamic subtest vma: SUCCESS (7.407s)
[299.241886] Starting dynamic subtest: evict
[300.889362] Dynamic subtest evict: SUCCESS (1.654s)
[300.897342] Starting dynamic subtest: gtt
[304.683292] Dynamic subtest gtt: SUCCESS (3.791s)
[304.692463] Starting dynamic subtest: hugepages
[305.647399] Dynamic subtest hugepages: SUCCESS (0.961s)
[305.656466] Starting dynamic subtest: memory_region
[308.974224] Dynamic subtest memory_region: SUCCESS (3.324s)
[308.975183] Subtest mock: SUCCESS (42.621s)
[309.007646] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[309.008442] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[309.010246] [061/131] (707s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[310.093338] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[310.170294] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[310.172223] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[310.174456] [062/131] (706s left) gem_render_copy_redux (normal)
[310.216351] Starting subtest: normal
[310.561086] Subtest normal: SUCCESS (0.335s)
[310.707980] [063/131] (705s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[310.744686] Starting subtest: basic-cpu-wc-noreloc
[310.749143] Subtest basic-cpu-wc-noreloc: SUCCESS (0.004s)
[310.895635] [064/131] (705s left) gem_ctx_param (invalid-set-no-zeromap)
[310.927963] Starting subtest: invalid-set-no-zeromap
[310.928694] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[311.015109] [065/131] (705s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[311.108278] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[311.109676] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[311.233349] [066/131] (705s left) i915_pm_rps (reset)
[311.270214] Starting subtest: reset
[315.836152] Subtest reset: SUCCESS (4.533s)
[315.945487] [067/131] (700s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[316.034235] Starting subtest: async-flip-with-page-flip-events-linear
[316.167733] Starting dynamic subtest: pipe-A-HDMI-A-1
[318.253212] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.076s)
[318.379653] Starting dynamic subtest: pipe-B-HDMI-A-1
[320.453160] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.070s)
[320.568526] Starting dynamic subtest: pipe-C-HDMI-A-1
[322.640573] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.072s)
[322.756814] Starting dynamic subtest: pipe-D-HDMI-A-1
[324.822251] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.064s)
[324.823001] Subtest async-flip-with-page-flip-events-linear: SUCCESS (8.778s)
[325.047481] [068/131] (691s left) perf_pmu (module-unload)
[325.095478] Starting subtest: module-unload
[327.898746] Subtest module-unload: FAIL (2.776s)
[327.920679] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[327.921490] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[327.923221] [069/131] (688s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[329.019395] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[329.020888] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[329.105557] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[329.106939] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[329.109858] [070/131] (687s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[329.145479] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[329.252400] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[329.337477] [071/131] (687s left) kms_cursor_crc (cursor-random-256x85)
[329.430147] Starting subtest: cursor-random-256x85
[329.444367] Starting dynamic subtest: pipe-A-HDMI-A-1
[330.668099] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.051s)
[330.675113] Starting dynamic subtest: pipe-D-HDMI-A-1
[332.521662] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.988s)
[332.522368] Subtest cursor-random-256x85: FAIL (3.092s)
[332.706010] [072/131] (684s left) kms_psr (psr-sprite-plane-move)
[332.794303] Subtest psr-sprite-plane-move: SKIP (0.000s)
[332.835986] [073/131] (683s left) kms_psr (fbc-pr-sprite-plane-onoff)
[332.921333] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[332.961033] [074/131] (683s left) kms_pm_rpm (pm-tiling)
[334.354843] Starting subtest: pm-tiling
[338.134614] Subtest pm-tiling: SUCCESS (3.780s)
[338.262414] [075/131] (678s left) gem_userptr_blits (invalid-null-pointer)
[338.304114] Starting subtest: invalid-null-pointer
[338.306454] Subtest invalid-null-pointer: SUCCESS (0.004s)
[338.456838] [076/131] (678s left) kms_content_protection (lic-type-1)
[338.548406] Starting subtest: lic-type-1
[338.562509] Subtest lic-type-1: SKIP (0.013s)
[338.672582] [077/131] (678s left) kms_atomic (plane-immutable-zpos)
[338.756676] Starting subtest: plane-immutable-zpos
[338.758472] Starting dynamic subtest: pipe-A-HDMI-A-1
[339.073166] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.315s)
[339.073930] Subtest plane-immutable-zpos: SUCCESS (0.317s)
[339.217271] [078/131] (677s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[339.303742] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[339.305769] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[339.396223] [079/131] (677s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[339.480506] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[339.481301] Starting dynamic subtest: pipe-A
[340.582151] Dynamic subtest pipe-A: SUCCESS (1.101s)
[340.591763] Starting dynamic subtest: pipe-B
[341.766715] Dynamic subtest pipe-B: SUCCESS (1.183s)
[341.776364] Starting dynamic subtest: pipe-C
[341.967834] Dynamic subtest pipe-C: SUCCESS (0.200s)
[341.978741] Starting dynamic subtest: pipe-D
[342.170270] Dynamic subtest pipe-D: SUCCESS (0.201s)
[342.172038] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.690s)
[342.363334] [080/131] (674s left) kms_psr (pr-sprite-mmap-cpu)
[342.463183] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[342.509116] [081/131] (674s left) gem_ctx_persistence (legacy-engines-cleanup)
[342.546689] Starting subtest: legacy-engines-cleanup
[342.547414] Starting dynamic subtest: render
[342.597195] Dynamic subtest render: SUCCESS (0.049s)
[342.614715] Starting dynamic subtest: bsd1
[342.651293] Dynamic subtest bsd1: SUCCESS (0.051s)
[342.669512] Starting dynamic subtest: bsd2
[342.722257] Dynamic subtest bsd2: SUCCESS (0.068s)
[342.742761] Starting dynamic subtest: blt
[342.801360] Dynamic subtest blt: SUCCESS (0.076s)
[342.820921] Starting dynamic subtest: vebox
[342.883446] Dynamic subtest vebox: SUCCESS (0.078s)
[342.884719] Subtest legacy-engines-cleanup: SUCCESS (0.337s)
[342.978273] [082/131] (674s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[343.065851] Starting subtest: cursor-tearing-framebuffer-change
[343.067591] Starting dynamic subtest: pipe-A-HDMI-A-1
[343.304513] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.237s)
[343.313758] Starting dynamic subtest: pipe-D-HDMI-A-1
[343.520235] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.212s)
[343.520923] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.454s)
[343.711525] [083/131] (673s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[343.800881] Starting subtest: 2x-cursor-vs-flip-atomic
[343.803318] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s)
[343.879262] [084/131] (673s left) kms_cursor_crc (cursor-random-32x10)
[343.965057] Starting subtest: cursor-random-32x10
[344.016238] Subtest cursor-random-32x10: SKIP (0.050s)
[344.142480] [085/131] (673s left) kms_psr (fbc-psr-primary-mmap-gtt)
[344.227343] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[344.274338] [086/131] (672s left) kms_big_fb (linear-8bpp-rotate-0)
[344.368865] Starting subtest: linear-8bpp-rotate-0
[345.627202] Subtest linear-8bpp-rotate-0: SUCCESS (1.257s)
[345.774298] [087/131] (671s left) gem_create (create-ext-cpu-access-sanity-check)
[345.931002] Starting subtest: create-ext-cpu-access-sanity-check
[345.932867] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[346.019010] [088/131] (671s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[346.112356] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[347.213562] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (1.100s)
[347.370351] [089/131] (670s left) kms_pm_rpm (cursor-dpms)
[348.764546] Starting subtest: cursor-dpms
[360.685574] Subtest cursor-dpms: SUCCESS (11.917s)
[360.900040] [090/131] (656s left) gem_lmem_swapping (verify-random-ccs)
[360.938269] Subtest verify-random-ccs: SKIP (0.000s)
[360.980192] [091/131] (656s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[361.065728] Starting subtest: flip-vs-cursor-toggle
[369.486981] Subtest flip-vs-cursor-toggle: SUCCESS (8.419s)
[369.648572] [092/131] (647s left) gem_lmem_swapping (heavy-verify-multi)
[369.686430] Subtest heavy-verify-multi: SKIP (0.000s)
[369.731097] [093/131] (647s left) i915_pm_freq_api (freq-reset)
[369.765767] Subtest freq-reset: SKIP (0.000s)
[369.805441] [094/131] (647s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[369.900586] Starting subtest: y-tiled-64bpp-rotate-90
[369.940136] Subtest y-tiled-64bpp-rotate-90: SKIP (0.038s)
[370.084141] [095/131] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[370.172554] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[370.173924] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[370.292562] [096/131] (647s left) kms_dirtyfb (default-dirtyfb-ioctl)
[370.377821] Starting subtest: default-dirtyfb-ioctl
[370.378549] Starting dynamic subtest: A-HDMI-A-1
[371.567199] Dynamic subtest A-HDMI-A-1: SUCCESS (1.187s)
[371.567979] Subtest default-dirtyfb-ioctl: SUCCESS (1.189s)
[371.702230] [097/131] (646s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[371.790647] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[371.791392] Starting dynamic subtest: pipe-A
[372.237685] Dynamic subtest pipe-A: SUCCESS (0.446s)
[372.249090] Starting dynamic subtest: pipe-B
[372.672411] Dynamic subtest pipe-B: SUCCESS (0.433s)
[372.680994] Starting dynamic subtest: pipe-C
[373.107500] Dynamic subtest pipe-C: SUCCESS (0.434s)
[373.124288] Starting dynamic subtest: pipe-D
[373.549943] Dynamic subtest pipe-D: SUCCESS (0.441s)
[373.550679] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (1.759s)
[373.761123] [098/131] (644s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[373.847608] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[373.849416] Starting dynamic subtest: pipe-A-valid-mode
[373.902998] Dynamic subtest pipe-A-valid-mode: SKIP (0.053s)
[373.904431] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.055s)
[374.022816] [099/131] (643s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[374.109759] Starting subtest: 2x-cursor-vs-flip-legacy
[374.112475] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[374.195797] [100/131] (643s left) gem_readwrite (write-bad-handle)
[374.228729] Starting subtest: write-bad-handle
[374.230108] Subtest write-bad-handle: SUCCESS (0.000s)
[374.325905] [101/131] (643s left) gem_reg_read (timestamp-monotonic)
[374.358524] Starting subtest: timestamp-monotonic
[378.510054] Subtest timestamp-monotonic: SUCCESS (4.145s)
[378.585976] [102/131] (639s left) kms_psr (fbc-psr2-cursor-plane-move)
[378.674388] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[378.715329] [103/131] (639s left) kms_plane_lowres (tiling-x)
[378.800215] Starting subtest: tiling-x
[378.800947] Starting dynamic subtest: pipe-A-HDMI-A-1
[385.754506] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.956s)
[385.802098] Starting dynamic subtest: pipe-B-HDMI-A-1
[392.619646] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.827s)
[392.695627] Starting dynamic subtest: pipe-C-HDMI-A-1
[399.485870] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.802s)
[399.533875] Starting dynamic subtest: pipe-D-HDMI-A-1
[406.347761] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (6.822s)
[406.414069] Subtest tiling-x: SUCCESS (27.620s)
[406.588080] [104/131] (611s left) kms_force_connector_basic (force-edid)
[406.720868] Starting subtest: force-edid
[406.867675] Subtest force-edid: SUCCESS (0.147s)
[407.051732] [105/131] (610s left) kms_getfb (getfb-handle-zero)
[407.136825] Starting subtest: getfb-handle-zero
[407.137551] Subtest getfb-handle-zero: SUCCESS (0.000s)
[407.258504] [106/131] (610s left) perf (missing-sample-flags)
[407.354458] Starting subtest: missing-sample-flags
[407.355208] Subtest missing-sample-flags: SUCCESS (0.000s)
[407.393022] [107/131] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[407.484978] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[407.486441] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[407.598786] [108/131] (610s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[407.688413] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[407.689757] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[407.815767] [109/131] (610s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[407.904575] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[407.905991] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[408.032563] [110/131] (610s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[408.125916] Starting subtest: 4-tiled-8bpp-rotate-180
[408.127354] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[408.239805] [111/131] (610s left) gem_exec_fence (syncobj-timeline-repeat)
[408.727130] Starting subtest: syncobj-timeline-repeat
[409.062141] Subtest syncobj-timeline-repeat: SUCCESS (0.337s)
[409.251976] [112/131] (609s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[409.342961] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[409.344414] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[409.448596] [113/131] (608s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[409.481887] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[409.482589] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[409.573948] [114/131] (608s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[409.663261] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[410.883011] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (1.220s)
[411.048199] [115/131] (607s left) gem_exec_schedule (lateslice)
[411.090212] Starting subtest: lateslice
[411.090940] Starting dynamic subtest: rcs0
[411.105799] Dynamic subtest rcs0: SUCCESS (0.015s)
[411.115035] Starting dynamic subtest: bcs0
[411.122693] Dynamic subtest bcs0: SUCCESS (0.016s)
[411.131158] Starting dynamic subtest: vcs0
[411.138690] Dynamic subtest vcs0: SUCCESS (0.015s)
[411.147463] Starting dynamic subtest: vcs1
[411.154857] Dynamic subtest vcs1: SUCCESS (0.015s)
[411.163589] Starting dynamic subtest: vecs0
[411.171797] Dynamic subtest vecs0: SUCCESS (0.016s)
[411.172582] Subtest lateslice: SUCCESS (0.082s)
[411.493422] [116/131] (607s left) kms_vblank (query-idle-hang)
[411.580623] Starting subtest: query-idle-hang
[411.582373] Starting dynamic subtest: pipe-A-HDMI-A-1
[425.917471] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.336s)
[425.928537] Starting dynamic subtest: pipe-D-HDMI-A-1
[439.728179] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.806s)
[439.730298] Subtest query-idle-hang: SUCCESS (28.150s)
[439.902804] [117/131] (578s left) syncobj_wait (reset-multiple-signaled)
[439.945958] Starting subtest: reset-multiple-signaled
[439.946648] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[440.031595] [118/131] (578s left) kms_flip_event_leak (basic)
[440.118802] Starting subtest: basic
[440.119565] Starting dynamic subtest: pipe-A-HDMI-A-1
[440.299118] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.179s)
[440.307672] Starting dynamic subtest: pipe-B-HDMI-A-1
[440.453134] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.152s)
[440.461439] Starting dynamic subtest: pipe-C-HDMI-A-1
[440.606478] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.152s)
[440.617245] Starting dynamic subtest: pipe-D-HDMI-A-1
[440.757990] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.150s)
[440.758666] Subtest basic: SUCCESS (0.641s)
[440.924205] [119/131] (577s left) gem_pwrite_snooped
[441.113825] [120/131] (577s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[441.152098] Starting subtest: yf-tiled-ccs-to-y-tiled
[441.152798] Starting dynamic subtest: smem
[441.253783] Dynamic subtest smem: SUCCESS (0.101s)
[441.254561] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.102s)
[441.455632] [121/131] (577s left) gem_ctx_shared (q-independent)
[441.495815] Starting subtest: Q-independent
[441.496535] Starting dynamic subtest: rcs0
[441.518339] Dynamic subtest rcs0: SUCCESS (0.022s)
[441.525981] Starting dynamic subtest: bcs0
[441.539494] Dynamic subtest bcs0: SUCCESS (0.020s)
[441.548051] Starting dynamic subtest: vcs0
[441.561688] Dynamic subtest vcs0: SUCCESS (0.021s)
[441.570168] Starting dynamic subtest: vcs1
[441.583818] Dynamic subtest vcs1: SUCCESS (0.021s)
[441.592050] Starting dynamic subtest: vecs0
[441.604618] Dynamic subtest vecs0: SUCCESS (0.020s)
[441.605410] Subtest Q-independent: SUCCESS (0.109s)
[441.814466] [122/131] (576s left) prime_mmap (test_userptr)
[441.846552] Starting subtest: test_userptr
[441.847236] Starting dynamic subtest: test_userptr-smem
[441.847930] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[441.848617] Subtest test_userptr: SUCCESS (0.002s)
[441.963457] [123/131] (576s left) kms_addfb_basic (bad-pitch-65536)
[441.995253] Starting subtest: bad-pitch-65536
[441.995955] Subtest bad-pitch-65536: SUCCESS (0.000s)
[442.158438] [124/131] (576s left) prime_self_import (basic-with_fd_dup)
[442.192000] Starting subtest: basic-with_fd_dup
[442.194629] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[442.314048] [125/131] (576s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[442.400143] Starting subtest: primary-y-tiled-reflect-x-0
[447.328078] Subtest primary-y-tiled-reflect-x-0: SUCCESS (4.928s)
[447.562062] [126/131] (571s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[447.649643] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[447.651456] Starting dynamic subtest: pipe-A-HDMI-A-1
[447.658156] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[447.665925] Starting dynamic subtest: pipe-B-HDMI-A-1
[447.672773] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[447.680018] Starting dynamic subtest: pipe-C-HDMI-A-1
[447.686831] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[447.694073] Starting dynamic subtest: pipe-D-HDMI-A-1
[447.701017] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[447.702407] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[447.897990] [127/131] (571s left) kms_addfb_basic (unused-modifier)
[447.931531] Starting subtest: unused-modifier
[447.932202] Subtest unused-modifier: SUCCESS (0.000s)
[448.103756] [128/131] (570s left) kms_vblank (wait-idle)
[448.187641] Starting subtest: wait-idle
[448.189415] Starting dynamic subtest: pipe-A-HDMI-A-1
[449.371019] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.181s)
[449.380611] Starting dynamic subtest: pipe-D-HDMI-A-1
[450.534068] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.159s)
[450.534795] Subtest wait-idle: SUCCESS (2.347s)
[450.683431] [129/131] (568s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[450.774702] Starting subtest: cursorA-vs-flipA-toggle
[461.629564] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.854s)
[461.800415] [130/131] (557s left) gen9_exec_parse (bb-start-far)
[461.847731] Subtest bb-start-far: SKIP (0.000s)
[461.887213] [131/131] (557s left) kms_addfb_basic (basic)
[461.919514] Starting subtest: basic
[461.920275] Subtest basic: SUCCESS (0.000s)
[462.105338] 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.