[64.156625] Initializing watchdogs [64.156707] /dev/watchdog0 [64.187039] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics] [64.202204] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [64.207083] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [64.210164] [001/133] (960s left) gem_workarounds (suspend-resume) [64.293605] Starting subtest: suspend-resume [89.686497] Subtest suspend-resume: SUCCESS (10.818s) [96.915048] [002/133] (934s left) gem_lmem_swapping (verify) [101.214834] Starting subtest: verify [101.215899] Starting dynamic subtest: lmem0 [142.042246] Dynamic subtest lmem0: SUCCESS (40.825s) [142.043149] Subtest verify: SUCCESS (40.825s) [143.425675] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true [143.427620] [003/133] (888s left) gem_exec_schedule (u-semaphore-noskip) [146.791526] Starting subtest: u-semaphore-noskip [147.211689] Subtest u-semaphore-noskip: SUCCESS (0.417s) [147.574878] [FACT gem_exec_schedule (u-semaphore-noskip)] new: kernel.kmod_is_loaded.i915: true [147.577354] [004/133] (884s left) core_setmaster (master-drop-set-user) [147.715502] Starting subtest: master-drop-set-user [147.737767] Subtest master-drop-set-user: SUCCESS (0.023s) [147.797068] [005/133] (884s left) gem_flink_basic (bad-flink) [147.840304] Starting subtest: bad-flink [147.841217] Subtest bad-flink: SUCCESS (0.000s) [147.943036] [006/133] (884s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [149.427878] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [149.429978] Starting dynamic subtest: pipe-A-HDMI-A-3 [149.439956] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [149.449921] Starting dynamic subtest: pipe-B-HDMI-A-3 [149.459606] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [149.469867] Starting dynamic subtest: pipe-C-HDMI-A-3 [149.480435] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [149.490302] Starting dynamic subtest: pipe-D-HDMI-A-3 [149.500974] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [149.502898] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s) [149.690108] [007/133] (882s left) gem_exec_reloc (basic-active) [149.740712] Subtest basic-active: SKIP (0.000s) [149.838206] [008/133] (882s left) kms_pm_rpm (package-g7) [153.592350] Starting subtest: package-g7 [153.596457] Subtest package-g7: SKIP (0.000s) [154.596337] [009/133] (877s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [156.090306] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [156.092057] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [156.230696] [010/133] (876s left) kms_cursor_crc (cursor-size-change) [157.726330] Starting subtest: cursor-size-change [157.727239] Starting dynamic subtest: pipe-A-HDMI-A-3 [158.714244] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.987s) [158.725584] Starting dynamic subtest: pipe-D-HDMI-A-3 [159.427393] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.710s) [159.428555] Subtest cursor-size-change: SUCCESS (1.701s) [160.093436] [011/133] (872s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [161.584897] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [161.587022] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [161.787314] [012/133] (870s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [161.840216] Starting subtest: mixed-tiled-to-yf-tiled-ccs [161.841103] Starting dynamic subtest: smem [161.955034] Dynamic subtest smem: SUCCESS (0.112s) [161.965024] Starting dynamic subtest: lmem0 [162.905995] Dynamic subtest lmem0: SUCCESS (0.950s) [162.907085] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (1.063s) [163.163473] [013/133] (869s left) i915_hangman (hangcheck-unterminated) [163.223201] Starting subtest: hangcheck-unterminated [172.593906] Subtest hangcheck-unterminated: SUCCESS (9.371s) [172.790199] [014/133] (859s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [172.849885] Starting subtest: map-fixed-invalidate-overlap-busy [172.851671] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [173.100524] [015/133] (859s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [174.590914] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [174.595801] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [174.778011] [016/133] (858s left) gem_ctx_exec (basic) [174.825309] Starting subtest: basic [174.831589] Subtest basic: SUCCESS (0.007s) [175.019792] [017/133] (858s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping) [176.503717] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping [176.505508] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s) [176.610156] [018/133] (856s left) gem_ppgtt (shrink-vs-evict-pinned) [176.667196] Starting subtest: shrink-vs-evict-pinned [182.421809] Subtest shrink-vs-evict-pinned: SUCCESS (5.751s) [182.531851] [019/133] (850s left) kms_psr (fbc-psr-primary-mmap-cpu) [184.016017] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s) [184.105684] [020/133] (849s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [185.596040] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [185.597854] Starting dynamic subtest: pipe-A-valid-mode [186.384980] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.787s) [186.385901] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.789s) [186.560272] [021/133] (846s left) kms_flip (flip-vs-expired-vblank-interruptible) [188.051729] Starting subtest: flip-vs-expired-vblank-interruptible [188.058554] Starting dynamic subtest: A-HDMI-A3 [195.798323] Dynamic subtest A-HDMI-A3: SUCCESS (7.738s) [195.834422] Starting dynamic subtest: B-HDMI-A3 [203.493834] Dynamic subtest B-HDMI-A3: SUCCESS (7.691s) [203.505320] Starting dynamic subtest: C-HDMI-A3 [211.147613] Dynamic subtest C-HDMI-A3: SUCCESS (7.651s) [211.183964] Starting dynamic subtest: D-HDMI-A3 [218.832092] Dynamic subtest D-HDMI-A3: SUCCESS (7.681s) [218.833972] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.779s) [219.033663] [022/133] (814s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [219.084545] Subtest writes-after-reads: SKIP (0.000s) [219.162102] [023/133] (814s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [220.647466] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [220.649507] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [220.774471] [024/133] (812s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [222.276290] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [222.277244] Starting dynamic subtest: pipe-A-valid-mode [223.433909] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.156s) [223.434782] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (1.158s) [223.604228] [025/133] (810s left) gem_userptr_blits (input-checking) [223.656975] Starting subtest: input-checking [223.657863] Subtest input-checking: SUCCESS (0.000s) [223.821048] [026/133] (809s left) gem_mmap_offset (bad-extensions) [223.866687] Starting subtest: bad-extensions [223.867544] Subtest bad-extensions: SUCCESS (0.000s) [224.058479] [027/133] (809s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [225.541341] Starting subtest: short-flip-before-cursor-atomic-transitions [226.581149] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.039s) [226.770265] [028/133] (807s left) perf (non-zero-reason) [226.886925] Starting subtest: non-zero-reason [226.887913] Starting dynamic subtest: 0-rcs0 [237.790060] Dynamic subtest 0-rcs0: SUCCESS (10.899s) [237.791241] Subtest non-zero-reason: SUCCESS (10.900s) [237.867938] [029/133] (796s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [239.371520] Starting subtest: yf-tiled-16bpp-rotate-180 [239.373194] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [239.543642] [030/133] (794s left) kms_psr (psr2-sprite-mmap-cpu) [241.031071] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s) [241.096972] [031/133] (792s left) prime_vgem (basic-gtt) [241.259624] Starting subtest: basic-gtt [241.261644] Subtest basic-gtt: SKIP (0.000s) [241.421729] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true [241.423967] [032/133] (792s left) gem_exec_balancer (noheartbeat) [241.795065] Starting subtest: noheartbeat [241.796821] Subtest noheartbeat: SKIP (0.000s) [241.905661] [033/133] (792s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [243.395176] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [243.396834] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [243.559597] [034/133] (790s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [245.051304] Starting subtest: fbc-rgb565-draw-mmap-gtt [245.053100] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [245.254819] [035/133] (789s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [246.745063] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [246.746616] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [246.928956] [036/133] (787s left) kms_properties (crtc-properties-atomic) [248.414524] Starting subtest: crtc-properties-atomic [248.415451] Starting dynamic subtest: pipe-A-HDMI-A-3 [248.723312] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.307s) [248.743456] Starting dynamic subtest: pipe-B-HDMI-A-3 [249.009656] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.284s) [249.021966] Starting dynamic subtest: pipe-C-HDMI-A-3 [249.281791] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.270s) [249.293656] Starting dynamic subtest: pipe-D-HDMI-A-3 [249.567427] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.284s) [249.568305] Subtest crtc-properties-atomic: SUCCESS (1.154s) [249.755555] [037/133] (784s left) gem_madvise (dontneed-before-exec) [249.798263] Starting subtest: dontneed-before-exec [249.802139] Subtest dontneed-before-exec: SKIP (0.003s) [249.899717] [038/133] (784s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [249.945923] Starting subtest: etime-single-wait-all-available-unsubmitted [250.057936] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.108s) [250.203382] [039/133] (784s left) syncobj_timeline (wait-any-complex) [250.249386] Starting subtest: wait-any-complex [250.312218] Subtest wait-any-complex: SUCCESS (0.063s) [250.438086] [040/133] (784s left) kms_psr (fbc-psr2-primary-blt) [251.923200] Subtest fbc-psr2-primary-blt: SKIP (0.000s) [251.999398] [041/133] (782s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc) [253.490334] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc [253.492203] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [253.658736] [042/133] (781s left) kms_cursor_edge_walk (64x64-right-edge) [255.146063] Starting subtest: 64x64-right-edge [255.148057] Starting dynamic subtest: pipe-A-HDMI-A-3 [258.462781] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.315s) [258.475947] Starting dynamic subtest: pipe-D-HDMI-A-3 [261.685833] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.221s) [261.686669] Subtest 64x64-right-edge: SUCCESS (6.539s) [261.870624] [043/133] (773s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier) [263.356545] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier [263.358487] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s) [263.489353] [044/133] (771s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [264.983556] Starting subtest: sprite-rotation-90-pos-100-0 [275.334047] Subtest sprite-rotation-90-pos-100-0: SUCCESS (10.350s) [275.605951] [045/133] (759s left) kms_async_flips (async-flip-hang) [277.092338] Starting subtest: async-flip-hang [277.331375] Starting dynamic subtest: pipe-A-HDMI-A-3 [291.979792] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (14.648s) [292.157263] Starting dynamic subtest: pipe-B-HDMI-A-3 [306.954553] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (14.807s) [307.137853] Starting dynamic subtest: pipe-C-HDMI-A-3 [331.980703] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (24.852s) [332.149425] Starting dynamic subtest: pipe-D-HDMI-A-3 [346.953594] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (14.814s) [346.954430] Subtest async-flip-hang: SUCCESS (69.860s) [347.320169] [046/133] (688s left) kms_plane_alpha_blend (alpha-7efc) [348.804353] Starting subtest: alpha-7efc [349.068830] Starting dynamic subtest: pipe-A-HDMI-A-3 [349.557511] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.488s) [349.591602] Starting dynamic subtest: pipe-D-HDMI-A-3 [350.169596] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.589s) [350.170754] Subtest alpha-7efc: SUCCESS (1.366s) [350.361141] [047/133] (685s left) i915_pm_rpm (reg-read-ioctl) [354.572312] Starting subtest: reg-read-ioctl [356.546004] Subtest reg-read-ioctl: SUCCESS (1.973s) [357.517234] [048/133] (678s left) kms_psr (fbc-pr-primary-mmap-cpu) [359.003359] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [359.084741] [049/133] (676s left) gem_ctx_persistence (engines-hang) [359.135882] Starting subtest: engines-hang [359.136707] Starting dynamic subtest: rcs0 [359.204603] Dynamic subtest rcs0: SUCCESS (0.068s) [359.221294] Starting dynamic subtest: bcs0 [359.297807] Dynamic subtest bcs0: SUCCESS (0.091s) [359.345629] Starting dynamic subtest: vcs0 [359.354644] Dynamic subtest vcs0: SUCCESS (0.053s) [359.371183] Starting dynamic subtest: vcs1 [359.444999] Dynamic subtest vcs1: SUCCESS (0.089s) [359.485657] Starting dynamic subtest: vecs0 [359.500669] Dynamic subtest vecs0: SUCCESS (0.053s) [359.501644] Subtest engines-hang: SUCCESS (0.365s) [359.684260] [050/133] (676s left) prime_self_import (basic-with_one_bo_two_files) [359.726571] Starting subtest: basic-with_one_bo_two_files [359.730704] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s) [359.915376] [051/133] (675s left) kms_cdclk (mode-transition) [359.962114] Subtest mode-transition: SKIP (0.000s) [360.048989] [052/133] (675s left) prime_mmap (test_forked) [360.094618] Starting subtest: test_forked [360.095508] Starting dynamic subtest: test_forked-smem [360.168418] Dynamic subtest test_forked-smem: SUCCESS (0.074s) [360.179782] Starting dynamic subtest: test_forked-lmem0 [360.242952] Dynamic subtest test_forked-lmem0: SUCCESS (0.073s) [360.243894] Subtest test_forked: SUCCESS (0.149s) [360.381878] [053/133] (675s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [361.887645] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [361.889367] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [362.068349] [054/133] (674s left) kms_big_fb (4-tiled-16bpp-rotate-180) [363.571859] Starting subtest: 4-tiled-16bpp-rotate-180 [363.573540] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s) [363.745550] [055/133] (672s left) api_intel_bb (object-noreloc-purge-cache-simple) [363.792261] Starting subtest: object-noreloc-purge-cache-simple [363.813378] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.022s) [363.954271] [056/133] (672s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [365.444013] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [365.445601] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [365.617943] [057/133] (670s left) gen9_exec_parse (secure-batches) [365.669363] Subtest secure-batches: SKIP (0.000s) [365.749811] [058/133] (670s left) gem_spin_batch (legacy) [365.806627] Starting subtest: legacy [365.807493] Starting dynamic subtest: default [369.061002] Dynamic subtest default: SUCCESS (3.247s) [369.073999] Starting dynamic subtest: render [372.297005] Dynamic subtest render: SUCCESS (3.230s) [372.309630] Starting dynamic subtest: bsd [375.532677] Dynamic subtest bsd: SUCCESS (3.229s) [375.545634] Starting dynamic subtest: bsd1 [378.768966] Dynamic subtest bsd1: SUCCESS (3.230s) [378.781634] Starting dynamic subtest: bsd2 [382.004378] Dynamic subtest bsd2: SUCCESS (3.230s) [382.017631] Starting dynamic subtest: blt [385.239957] Dynamic subtest blt: SUCCESS (3.229s) [385.252747] Starting dynamic subtest: vebox [388.476959] Dynamic subtest vebox: SUCCESS (3.231s) [388.478979] Subtest legacy: SUCCESS (22.667s) [388.762288] [059/133] (647s left) kms_big_fb (y-tiled-64bpp-rotate-180) [390.277602] Starting subtest: y-tiled-64bpp-rotate-180 [392.459919] Subtest y-tiled-64bpp-rotate-180: SUCCESS (2.178s) [392.732675] [060/133] (643s left) kms_big_fb (x-tiled-16bpp-rotate-0) [394.237498] Starting subtest: x-tiled-16bpp-rotate-0 [396.309944] Subtest x-tiled-16bpp-rotate-0: SUCCESS (2.068s) [396.503212] [061/133] (640s left) api_intel_allocator (gem-pool) [396.548674] Starting subtest: gem-pool [396.571809] Subtest gem-pool: SUCCESS (0.023s) [396.778778] [062/133] (640s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [398.264501] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [398.266211] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [398.470738] [063/133] (638s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [399.955600] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs [399.956566] Starting dynamic subtest: pipe-A-HDMI-A-3 [399.965206] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [399.977069] Starting dynamic subtest: pipe-B-HDMI-A-3 [399.985526] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [399.997174] Starting dynamic subtest: pipe-C-HDMI-A-3 [400.006380] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [400.017903] Starting dynamic subtest: pipe-D-HDMI-A-3 [400.027208] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [400.029027] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.012s) [400.226431] [064/133] (636s left) gem_exec_balancer (sliced) [400.284811] Starting subtest: sliced [400.286555] Subtest sliced: SKIP (0.000s) [400.708399] [065/133] (636s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [402.193788] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [402.194850] Starting dynamic subtest: pipe-A-HDMI-A-3 [402.220666] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.003s) [402.232666] Starting dynamic subtest: pipe-B-HDMI-A-3 [402.258565] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.003s) [402.270449] Starting dynamic subtest: pipe-C-HDMI-A-3 [402.298042] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.003s) [402.310220] Starting dynamic subtest: pipe-D-HDMI-A-3 [402.336788] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.003s) [402.338926] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.020s) [402.471729] [066/133] (634s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [403.962185] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [403.963831] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [404.146023] [067/133] (633s left) gem_request_retire (retire-vma-not-inactive) [404.198860] Starting subtest: retire-vma-not-inactive [404.235769] Subtest retire-vma-not-inactive: SUCCESS (0.036s) [404.448954] [068/133] (632s left) kms_psr (pr-cursor-plane-move) [405.934597] Subtest pr-cursor-plane-move: SKIP (0.000s) [406.114569] [069/133] (631s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [407.606436] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [407.608375] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [407.830220] [070/133] (629s left) syncobj_wait (invalid-reset-illegal-handle) [407.891178] Starting subtest: invalid-reset-illegal-handle [407.892039] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [408.007613] [071/133] (629s left) kms_properties (get_properties-sanity-non-atomic) [409.493702] Starting subtest: get_properties-sanity-non-atomic [409.496912] Subtest get_properties-sanity-non-atomic: SUCCESS (0.004s) [409.611585] [072/133] (628s left) sysfs_timeslice_duration (idempotent) [409.669284] Starting subtest: idempotent [409.670442] Starting dynamic subtest: vecs0 [409.671388] Dynamic subtest vecs0: SUCCESS (0.001s) [409.683615] Starting dynamic subtest: vcs0 [409.684869] Dynamic subtest vcs0: SUCCESS (0.001s) [409.696641] Starting dynamic subtest: bcs0 [409.697898] Dynamic subtest bcs0: SUCCESS (0.001s) [409.709534] Starting dynamic subtest: rcs0 [409.710842] Dynamic subtest rcs0: SUCCESS (0.001s) [409.722629] Starting dynamic subtest: vcs1 [409.723882] Dynamic subtest vcs1: SUCCESS (0.001s) [409.725020] Subtest idempotent: SUCCESS (0.011s) [409.804263] [073/133] (628s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [411.287949] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [411.288770] Starting dynamic subtest: pipe-A [411.444640] Dynamic subtest pipe-A: SUCCESS (0.156s) [411.459864] Starting dynamic subtest: pipe-B [411.603365] Dynamic subtest pipe-B: SUCCESS (0.157s) [411.615049] Starting dynamic subtest: pipe-C [411.743676] Dynamic subtest pipe-C: SUCCESS (0.139s) [411.759176] Starting dynamic subtest: pipe-D [411.883890] Dynamic subtest pipe-D: SUCCESS (0.139s) [411.884753] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.597s) [412.076712] [074/133] (625s left) gem_exec_fence (syncobj-invalid-flags) [412.549777] Starting subtest: syncobj-invalid-flags [412.550659] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [412.944014] [075/133] (625s left) gem_ringfill (legacy-basic) [413.330463] Starting subtest: legacy-basic [413.333651] Starting dynamic subtest: default [413.418641] Dynamic subtest default: SUCCESS (0.087s) [413.434730] Starting dynamic subtest: render [413.462446] Dynamic subtest render: SUCCESS (0.042s) [413.483387] Starting dynamic subtest: bsd [413.506465] Dynamic subtest bsd: SUCCESS (0.042s) [413.530353] Starting dynamic subtest: bsd1 [413.552492] Dynamic subtest bsd1: SUCCESS (0.043s) [413.572971] Starting dynamic subtest: bsd2 [413.596455] Dynamic subtest bsd2: SUCCESS (0.042s) [413.616933] Starting dynamic subtest: blt [413.640556] Dynamic subtest blt: SUCCESS (0.042s) [413.660950] Starting dynamic subtest: vebox [413.684451] Dynamic subtest vebox: SUCCESS (0.042s) [413.685466] Subtest legacy-basic: SUCCESS (0.355s) [413.852339] [076/133] (624s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [415.338639] Starting subtest: primary-yf-tiled-reflect-x-0 [415.441910] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.103s) [415.651761] [077/133] (622s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping) [417.137288] Starting subtest: pixel-format-y-tiled-modifier-source-clamping [417.174748] Starting dynamic subtest: pipe-A-plane-0 [418.341437] Dynamic subtest pipe-A-plane-0: SUCCESS (1.166s) [418.395098] Starting dynamic subtest: pipe-A-plane-3 [419.174463] Dynamic subtest pipe-A-plane-3: SUCCESS (0.828s) [419.211180] Starting dynamic subtest: pipe-A-plane-5 [419.842570] Dynamic subtest pipe-A-plane-5: SUCCESS (0.664s) [420.023365] Starting dynamic subtest: pipe-B-plane-0 [420.928861] Dynamic subtest pipe-B-plane-0: SUCCESS (0.916s) [420.944958] Starting dynamic subtest: pipe-B-plane-3 [421.812034] Dynamic subtest pipe-B-plane-3: SUCCESS (0.879s) [421.830947] Starting dynamic subtest: pipe-B-plane-5 [422.511702] Dynamic subtest pipe-B-plane-5: SUCCESS (0.697s) [422.584731] Subtest pixel-format-y-tiled-modifier-source-clamping: SUCCESS (5.446s) [422.778336] [078/133] (615s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [424.265794] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [424.358660] [079/133] (614s left) kms_cursor_crc (cursor-random-32x10) [425.956322] Starting subtest: cursor-random-32x10 [426.012750] Subtest cursor-random-32x10: SKIP (0.053s) [426.437012] [080/133] (612s left) gem_flink_basic (double-flink) [426.483304] Starting subtest: double-flink [426.484314] Subtest double-flink: SUCCESS (0.000s) [426.644959] [081/133] (611s left) gem_ctx_param (basic) [426.691627] Starting subtest: basic [426.692627] Subtest basic: SUCCESS (0.001s) [426.818089] [082/133] (611s left) kms_psr (psr-primary-mmap-cpu) [428.303912] Subtest psr-primary-mmap-cpu: SKIP (0.000s) [428.392621] [083/133] (610s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [429.882261] Starting subtest: switch-modeset-ultra-joiner-big-joiner [429.883962] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [430.005751] [084/133] (608s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [431.522864] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [432.091704] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.570s) [432.353360] [085/133] (606s left) kms_properties (invalid-properties-atomic) [433.840709] Starting subtest: invalid-properties-atomic [434.798906] Subtest invalid-properties-atomic: SUCCESS (0.956s) [434.909850] [086/133] (604s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [436.398938] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [436.471917] [087/133] (602s left) kms_invalid_mode (zero-clock) [437.960230] Starting subtest: zero-clock [437.961132] Starting dynamic subtest: pipe-A-HDMI-A-3 [437.997312] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.037s) [438.011532] Starting dynamic subtest: pipe-B-HDMI-A-3 [438.012445] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s) [438.024575] Starting dynamic subtest: pipe-C-HDMI-A-3 [438.025603] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s) [438.038324] Starting dynamic subtest: pipe-D-HDMI-A-3 [438.039204] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s) [438.040027] Subtest zero-clock: SUCCESS (0.049s) [438.183573] [088/133] (600s left) gem_userptr_blits (unsync-unmap) [438.237442] Subtest unsync-unmap: SKIP (0.000s) [438.461827] [089/133] (600s left) kms_chamelium_edid (dp-edid-resolution-list) [439.987060] Subtest dp-edid-resolution-list: SKIP (0.000s) [440.108344] [090/133] (599s left) syncobj_basic (bad-create-flags) [440.155376] Starting subtest: bad-create-flags [440.156257] Subtest bad-create-flags: SUCCESS (0.000s) [440.265932] [091/133] (599s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [441.756376] Starting subtest: fbcpsr-farfromfence-mmap-gtt [441.758082] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [441.947269] [092/133] (597s left) gem_exec_reloc (basic-cpu-read-noreloc) [441.998634] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [442.109554] [093/133] (597s left) kms_flip (modeset-vs-vblank-race-interruptible) [443.601205] Starting subtest: modeset-vs-vblank-race-interruptible [443.608756] Starting dynamic subtest: A-HDMI-A3 [446.635856] Dynamic subtest A-HDMI-A3: SUCCESS (3.027s) [446.653540] Starting dynamic subtest: B-HDMI-A3 [449.602066] Dynamic subtest B-HDMI-A3: SUCCESS (2.964s) [449.615751] Starting dynamic subtest: C-HDMI-A3 [452.564272] Dynamic subtest C-HDMI-A3: SUCCESS (2.960s) [452.577915] Starting dynamic subtest: D-HDMI-A3 [455.547499] Dynamic subtest D-HDMI-A3: SUCCESS (2.981s) [455.550007] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (11.948s) [455.772716] [094/133] (583s left) kms_properties (crtc-properties-legacy) [457.265860] Starting subtest: crtc-properties-legacy [457.266919] Starting dynamic subtest: pipe-A-HDMI-A-3 [457.571108] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.299s) [457.603770] Starting dynamic subtest: pipe-B-HDMI-A-3 [457.873337] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.296s) [457.886912] Starting dynamic subtest: pipe-C-HDMI-A-3 [458.144432] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.268s) [458.158878] Starting dynamic subtest: pipe-D-HDMI-A-3 [458.431229] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.285s) [458.432210] Subtest crtc-properties-legacy: SUCCESS (1.167s) [458.612301] [095/133] (581s left) sriov_basic (bind-unbind-vf) [458.659643] Subtest bind-unbind-vf: SKIP (0.000s) [458.739924] [096/133] (581s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [460.230311] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [460.232062] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [460.406736] [097/133] (579s left) syncobj_timeline (multi-wait-all-available-signaled) [460.453533] Starting subtest: multi-wait-all-available-signaled [460.454390] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s) [460.592470] [098/133] (579s left) gem_lmem_swapping (heavy-random) [464.829969] Starting subtest: heavy-random [464.830811] Starting dynamic subtest: lmem0 [470.711872] Dynamic subtest lmem0: SUCCESS (5.884s) [470.712866] Subtest heavy-random: SUCCESS (5.886s) [471.938104] [FACT gem_lmem_swapping (heavy-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [471.939216] [FACT gem_lmem_swapping (heavy-random)] deleted: kernel.kmod_is_loaded.i915: true [471.941711] [099/133] (568s left) gem_ctx_persistence (legacy-engines-hostile) [475.331423] Starting subtest: legacy-engines-hostile [475.335365] Starting dynamic subtest: render [475.414481] Dynamic subtest render: SUCCESS (0.080s) [475.428035] Starting dynamic subtest: bsd1 [475.511527] Dynamic subtest bsd1: SUCCESS (0.094s) [475.573971] Starting dynamic subtest: bsd2 [475.591241] Dynamic subtest bsd2: SUCCESS (0.071s) [475.622118] Starting dynamic subtest: blt [475.657579] Dynamic subtest blt: SUCCESS (0.060s) [475.676721] Starting dynamic subtest: vebox [475.677719] Dynamic subtest vebox: SUCCESS (0.017s) [475.680865] Subtest legacy-engines-hostile: SUCCESS (0.348s) [475.820766] [FACT gem_ctx_persistence (legacy-engines-hostile)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [475.823875] [FACT gem_ctx_persistence (legacy-engines-hostile)] new: kernel.kmod_is_loaded.i915: true [475.827822] [100/133] (564s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [477.323590] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [477.325440] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [477.565363] [101/133] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [479.057775] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [479.059633] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [479.238260] [102/133] (561s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [480.787329] Starting subtest: dp-mst-lic-type-0-hdcp14 [480.789272] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [480.982118] [103/133] (559s left) kms_draw_crc (draw-method-render) [482.469203] Starting subtest: draw-method-render [482.470121] Starting dynamic subtest: xrgb8888-untiled [482.891955] Dynamic subtest xrgb8888-untiled: SUCCESS (0.421s) [482.934183] Starting dynamic subtest: rgb565-untiled [483.258597] Dynamic subtest rgb565-untiled: SUCCESS (0.359s) [483.303171] Starting dynamic subtest: xrgb2101010-untiled [483.608623] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.342s) [483.653189] Starting dynamic subtest: xbgr16161616f-untiled [483.992092] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.375s) [484.037710] Starting dynamic subtest: xrgb8888-xtiled [484.192173] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.192s) [484.238154] Starting dynamic subtest: rgb565-xtiled [484.392138] Dynamic subtest rgb565-xtiled: SUCCESS (0.192s) [484.431688] Starting dynamic subtest: xrgb2101010-xtiled [484.575499] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.175s) [484.619227] Starting dynamic subtest: xbgr16161616f-xtiled [484.775464] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.192s) [484.819253] Starting dynamic subtest: xrgb8888-ytiled [484.975512] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.192s) [484.998001] Starting dynamic subtest: rgb565-ytiled [485.142230] Dynamic subtest rgb565-ytiled: SUCCESS (0.159s) [485.185105] Starting dynamic subtest: xrgb2101010-ytiled [485.325324] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.175s) [485.340581] Starting dynamic subtest: xbgr16161616f-ytiled [485.491969] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.161s) [485.500983] Subtest draw-method-render: SUCCESS (3.026s) [485.695673] [104/133] (554s left) gem_fence_thrash (bo-write-verify-threaded-y) [485.738607] Starting subtest: bo-write-verify-threaded-y [485.741202] Subtest bo-write-verify-threaded-y: SKIP (0.003s) [485.818711] [105/133] (554s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [487.326260] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [487.328316] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [487.517807] [106/133] (553s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [489.008472] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [489.010405] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [489.188078] [107/133] (551s left) gem_exec_schedule (preempt-other) [489.252212] Starting subtest: preempt-other [489.253100] Starting dynamic subtest: rcs0 [489.384077] Dynamic subtest rcs0: SUCCESS (0.131s) [489.396915] Starting dynamic subtest: bcs0 [489.496773] Dynamic subtest bcs0: SUCCESS (0.111s) [489.509226] Starting dynamic subtest: vcs0 [489.609183] Dynamic subtest vcs0: SUCCESS (0.111s) [489.621876] Starting dynamic subtest: vcs1 [489.720172] Dynamic subtest vcs1: SUCCESS (0.109s) [489.732927] Starting dynamic subtest: vecs0 [489.833097] Dynamic subtest vecs0: SUCCESS (0.111s) [489.834099] Subtest preempt-other: SUCCESS (0.582s) [490.293123] [108/133] (550s left) kms_color (ctm-0-75) [491.779786] Starting subtest: ctm-0-75 [491.780776] Starting dynamic subtest: pipe-A-HDMI-A-3 [493.831810] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.052s) [493.844280] Starting dynamic subtest: pipe-B-HDMI-A-3 [495.698659] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.866s) [495.712195] Starting dynamic subtest: pipe-C-HDMI-A-3 [497.599025] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (1.898s) [497.612579] Starting dynamic subtest: pipe-D-HDMI-A-3 [499.461652] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.860s) [499.462596] Subtest ctm-0-75: SUCCESS (7.683s) [499.649810] [109/133] (541s left) gem_ctx_exec (basic-close-race) [499.699662] Starting subtest: basic-close-race [505.227038] Subtest basic-close-race: SUCCESS (5.523s) [505.459112] [110/133] (535s left) gem_userptr_blits (invalid-mmap-offset-unsync) [505.512573] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [505.753256] [111/133] (535s left) kms_cursor_crc (cursor-onscreen-64x21) [507.393965] Starting subtest: cursor-onscreen-64x21 [507.401345] Starting dynamic subtest: pipe-A-HDMI-A-3 [510.186805] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.785s) [510.222613] Starting dynamic subtest: pipe-D-HDMI-A-3 [512.838106] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.624s) [512.839050] Subtest cursor-onscreen-64x21: SUCCESS (5.444s) [513.307632] [112/133] (528s left) gem_exec_whisper (basic-fds) [513.366456] Starting subtest: basic-fds [517.466191] Subtest basic-fds: SUCCESS (4.095s) [517.720120] [113/133] (523s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [519.210276] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [519.212218] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [519.404862] [114/133] (522s left) vgem_basic (debugfs) [519.464153] Starting subtest: debugfs [519.465107] Subtest debugfs: SUCCESS (0.000s) [519.569829] [115/133] (522s left) kms_vblank (query-forked-busy-hang) [521.053688] Starting subtest: query-forked-busy-hang [521.055361] Starting dynamic subtest: pipe-A-HDMI-A-3 [548.019439] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.964s) [548.034851] Starting dynamic subtest: pipe-D-HDMI-A-3 [573.033478] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (25.008s) [573.036350] Subtest query-forked-busy-hang: SUCCESS (51.981s) [573.217994] [116/133] (468s left) syncobj_wait (multi-wait-all-for-submit-submitted) [573.264744] Starting subtest: multi-wait-all-for-submit-submitted [573.370003] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s) [573.543847] [117/133] (468s left) gem_busy (parallel) [573.789221] Starting subtest: parallel [573.795927] Starting dynamic subtest: rcs0 [573.882712] Dynamic subtest rcs0: SUCCESS (0.093s) [573.899279] Starting dynamic subtest: bcs0 [573.941313] Dynamic subtest bcs0: SUCCESS (0.056s) [573.972550] Starting dynamic subtest: vcs0 [574.015003] Dynamic subtest vcs0: SUCCESS (0.071s) [574.031264] Starting dynamic subtest: vcs1 [574.074757] Dynamic subtest vcs1: SUCCESS (0.057s) [574.093757] Starting dynamic subtest: vecs0 [574.136350] Dynamic subtest vecs0: SUCCESS (0.059s) [574.138373] Subtest parallel: SUCCESS (0.349s) [574.548526] [118/133] (467s left) i915_query (engine-info) [574.717938] Starting subtest: engine-info [574.734092] Subtest engine-info: SUCCESS (0.012s) [574.898431] [119/133] (467s left) gem_ctx_shared (q-smoketest-all) [575.029839] Starting subtest: Q-smoketest-all [607.332214] Subtest Q-smoketest-all: SUCCESS (32.293s) [607.688301] [120/133] (434s left) kms_big_fb (4-tiled-8bpp-rotate-180) [609.195043] Starting subtest: 4-tiled-8bpp-rotate-180 [609.197046] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s) [609.387258] [121/133] (432s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [610.879549] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [610.881495] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [611.067225] [122/133] (431s left) kms_chamelium_hpd (dp-hpd) [612.590704] Subtest dp-hpd: SKIP (0.000s) [612.708878] [123/133] (429s left) gem_reg_read (timestamp-monotonic) [612.756507] Starting subtest: timestamp-monotonic [617.647612] Subtest timestamp-monotonic: SUCCESS (4.889s) [617.758946] [124/133] (424s left) syncobj_eventfd (binary-wait-before-signal) [617.807393] Starting subtest: binary-wait-before-signal [617.836646] Subtest binary-wait-before-signal: SUCCESS (0.031s) [617.963985] [125/133] (424s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [618.012165] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [618.012964] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s) [618.146544] [126/133] (424s left) i915_drm_fdinfo (virtual-busy-hang) [618.195848] Starting subtest: virtual-busy-hang [618.197518] Subtest virtual-busy-hang: SKIP (0.000s) [618.309640] [127/133] (424s left) kms_flip (2x-flip-vs-expired-vblank) [619.796459] Starting subtest: 2x-flip-vs-expired-vblank [619.814942] Subtest 2x-flip-vs-expired-vblank: SKIP (0.019s) [620.042386] [128/133] (422s left) kms_pm_rpm (basic-pci-d3-state) [623.561174] Starting subtest: basic-pci-d3-state [624.660399] Subtest basic-pci-d3-state: SUCCESS (1.103s) [625.536200] [129/133] (417s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [627.038378] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [627.040210] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [627.236029] [130/133] (415s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [628.722128] Starting subtest: flip-vs-cursor-atomic-transitions [640.309705] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (11.587s) [640.492096] [131/133] (402s left) kms_sequence (get-forked) [641.978798] Starting subtest: get-forked [641.979788] Starting dynamic subtest: pipe-A-HDMI-A-3 [644.428691] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.448s) [644.442159] Starting dynamic subtest: pipe-B-HDMI-A-3 [646.691897] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.261s) [646.704833] Starting dynamic subtest: pipe-C-HDMI-A-3 [648.994428] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.300s) [649.006962] Starting dynamic subtest: pipe-D-HDMI-A-3 [651.268393] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.272s) [651.269285] Subtest get-forked: SUCCESS (9.291s) [651.459332] [132/133] (391s left) kms_flip (plain-flip-fb-recreate) [652.945624] Starting subtest: plain-flip-fb-recreate [652.952000] Starting dynamic subtest: A-HDMI-A3 [660.994370] Dynamic subtest A-HDMI-A3: SUCCESS (8.041s) [661.034280] Starting dynamic subtest: B-HDMI-A3 [669.009818] Dynamic subtest B-HDMI-A3: SUCCESS (8.005s) [669.049051] Starting dynamic subtest: C-HDMI-A3 [677.028617] Dynamic subtest C-HDMI-A3: SUCCESS (8.008s) [677.072513] Starting dynamic subtest: D-HDMI-A3 [685.046114] Dynamic subtest D-HDMI-A3: SUCCESS (8.008s) [685.056396] Subtest plain-flip-fb-recreate: SUCCESS (32.111s) [685.369465] [133/133] (358s left) perf_pmu (busy-idle-no-semaphores) [685.419896] Starting subtest: busy-idle-no-semaphores [685.420782] Starting dynamic subtest: rcs0 [686.097931] Dynamic subtest rcs0: SUCCESS (0.673s) [686.118964] Starting dynamic subtest: bcs0 [686.758140] Dynamic subtest bcs0: SUCCESS (0.652s) [686.778967] Starting dynamic subtest: vcs0 [687.418145] Dynamic subtest vcs0: SUCCESS (0.652s) [687.435590] Starting dynamic subtest: vcs1 [688.076379] Dynamic subtest vcs1: SUCCESS (0.651s) [688.093613] Starting dynamic subtest: vecs0 [688.734612] Dynamic subtest vecs0: SUCCESS (0.651s) [688.736724] Subtest busy-idle-no-semaphores: SUCCESS (3.315s) [688.907375] Closing watchdogs results: parsing output: 0/ for test: gem_workarounds results: parsing output: 1/ for test: gem_lmem_swapping results: parsing output: 2/ for test: gem_exec_schedule results: parsing output: 3/ for test: core_setmaster results: parsing output: 4/ for test: gem_flink_basic results: parsing output: 5/ for test: kms_ccs results: parsing output: 6/ for test: gem_exec_reloc results: parsing output: 7/ for test: kms_pm_rpm results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_cursor_crc results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_render_copy results: parsing output: 12/ for test: i915_hangman results: parsing output: 13/ for test: gem_userptr_blits results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_ctx_exec results: parsing output: 16/ for test: kms_plane results: parsing output: 17/ for test: gem_ppgtt results: parsing output: 18/ for test: kms_psr results: parsing output: 19/ for test: kms_flip_scaled_crc results: parsing output: 20/ for test: kms_flip results: parsing output: 21/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 22/ for test: kms_cursor_legacy results: parsing output: 23/ for test: kms_flip_scaled_crc results: parsing output: 24/ for test: gem_userptr_blits results: parsing output: 25/ for test: gem_mmap_offset results: parsing output: 26/ for test: kms_cursor_legacy results: parsing output: 27/ for test: perf results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: prime_vgem results: parsing output: 31/ for test: gem_exec_balancer results: parsing output: 32/ for test: kms_frontbuffer_tracking 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_properties results: parsing output: 36/ for test: gem_madvise results: parsing output: 37/ for test: syncobj_timeline results: parsing output: 38/ for test: syncobj_timeline results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_cursor_edge_walk results: parsing output: 42/ for test: kms_plane results: parsing output: 43/ for test: kms_rotation_crc results: parsing output: 44/ for test: kms_async_flips results: parsing output: 45/ for test: kms_plane_alpha_blend results: parsing output: 46/ for test: i915_pm_rpm results: parsing output: 47/ for test: kms_psr results: parsing output: 48/ for test: gem_ctx_persistence results: parsing output: 49/ for test: prime_self_import results: parsing output: 50/ for test: kms_cdclk results: parsing output: 51/ for test: prime_mmap results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: api_intel_bb results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gen9_exec_parse results: parsing output: 57/ for test: gem_spin_batch results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: api_intel_allocator results: parsing output: 61/ for test: kms_ccs results: parsing output: 62/ for test: kms_ccs results: parsing output: 63/ for test: gem_exec_balancer results: parsing output: 64/ for test: kms_ccs results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gem_request_retire results: parsing output: 67/ for test: kms_psr results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: syncobj_wait results: parsing output: 70/ for test: kms_properties results: parsing output: 71/ for test: sysfs_timeslice_duration results: parsing output: 72/ for test: kms_plane_scaling results: parsing output: 73/ for test: gem_exec_fence results: parsing output: 74/ for test: gem_ringfill results: parsing output: 75/ for test: kms_rotation_crc results: parsing output: 76/ for test: kms_plane results: parsing output: 77/ for test: kms_psr2_sf results: parsing output: 78/ for test: kms_cursor_crc results: parsing output: 79/ for test: gem_flink_basic results: parsing output: 80/ for test: gem_ctx_param results: parsing output: 81/ for test: kms_psr results: parsing output: 82/ for test: kms_joiner results: parsing output: 83/ for test: kms_big_fb results: parsing output: 84/ for test: kms_properties results: parsing output: 85/ for test: kms_psr2_sf results: parsing output: 86/ for test: kms_invalid_mode results: parsing output: 87/ for test: gem_userptr_blits results: parsing output: 88/ for test: kms_chamelium_edid results: parsing output: 89/ for test: syncobj_basic results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_exec_reloc results: parsing output: 92/ for test: kms_flip results: parsing output: 93/ for test: kms_properties results: parsing output: 94/ for test: sriov_basic results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: syncobj_timeline results: parsing output: 97/ for test: gem_lmem_swapping results: parsing output: 98/ for test: gem_ctx_persistence results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_content_protection results: parsing output: 102/ for test: kms_draw_crc results: parsing output: 103/ for test: gem_fence_thrash results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: gem_exec_schedule results: parsing output: 107/ for test: kms_color results: parsing output: 108/ for test: gem_ctx_exec results: parsing output: 109/ for test: gem_userptr_blits results: parsing output: 110/ for test: kms_cursor_crc results: parsing output: 111/ for test: gem_exec_whisper results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: vgem_basic results: parsing output: 114/ for test: kms_vblank results: parsing output: 115/ for test: syncobj_wait results: parsing output: 116/ for test: gem_busy results: parsing output: 117/ for test: i915_query results: parsing output: 118/ for test: gem_ctx_shared results: parsing output: 119/ for test: kms_big_fb results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_chamelium_hpd results: parsing output: 122/ for test: gem_reg_read results: parsing output: 123/ for test: syncobj_eventfd results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: i915_drm_fdinfo results: parsing output: 126/ for test: kms_flip results: parsing output: 127/ for test: kms_pm_rpm results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_cursor_legacy results: parsing output: 130/ for test: kms_sequence results: parsing output: 131/ for test: kms_flip results: parsing output: 132/ for test: perf_pmu Done.