[44.142683] Initializing watchdogs [44.142751] /dev/watchdog0 [44.158960] [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.164779] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [44.167691] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [44.169794] [001/156] (960s left) kms_busy (basic-hang) [44.274638] Starting subtest: basic-hang [44.275361] Starting dynamic subtest: flip-pipe-A [44.639387] Dynamic subtest flip-pipe-A: SUCCESS (0.364s) [44.646754] Starting dynamic subtest: modeset-pipe-A [45.229635] Dynamic subtest modeset-pipe-A: SUCCESS (0.590s) [45.240682] Starting dynamic subtest: flip-pipe-D [45.531282] Dynamic subtest flip-pipe-D: SUCCESS (0.297s) [45.537617] Starting dynamic subtest: modeset-pipe-D [46.109679] Dynamic subtest modeset-pipe-D: SUCCESS (0.578s) [46.110461] Subtest basic-hang: SUCCESS (1.836s) [46.243987] [002/156] (958s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [46.345364] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu [46.346798] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [46.438326] [003/156] (958s left) gem_exec_schedule (pi-distinct-iova) [46.607276] Starting subtest: pi-distinct-iova [46.608429] Starting dynamic subtest: rcs0 [46.636896] Dynamic subtest rcs0: SUCCESS (0.030s) [46.644248] Starting dynamic subtest: bcs0 [46.661425] Dynamic subtest bcs0: SUCCESS (0.025s) [46.668816] Starting dynamic subtest: vcs0 [46.684197] Dynamic subtest vcs0: SUCCESS (0.022s) [46.690961] Starting dynamic subtest: vcs1 [46.707028] Dynamic subtest vcs1: SUCCESS (0.022s) [46.716323] Starting dynamic subtest: vecs0 [46.730203] Dynamic subtest vecs0: SUCCESS (0.023s) [46.730971] Subtest pi-distinct-iova: SUCCESS (0.124s) [46.903849] [004/156] (957s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render) [46.996109] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render [46.997449] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [47.097120] [005/156] (957s left) kms_flip (2x-busy-flip) [47.185347] Starting subtest: 2x-busy-flip [47.194768] Subtest 2x-busy-flip: SKIP (0.009s) [47.269051] [006/156] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt) [47.362080] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt [47.363420] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [47.468238] [007/156] (957s left) kms_vrr (max-min) [47.556574] Starting subtest: max-min [47.558630] Subtest max-min: SKIP (0.000s) [47.612151] [008/156] (957s left) kms_cursor_crc (cursor-random-max-size) [47.705468] Starting subtest: cursor-random-max-size [47.707483] Subtest cursor-random-max-size: SKIP (0.000s) [47.797995] [009/156] (957s left) kms_flip (flip-vs-suspend-interruptible) [47.894421] Starting subtest: flip-vs-suspend-interruptible [47.895134] Starting dynamic subtest: A-HDMI-A1 [193.047130] Dynamic subtest A-HDMI-A1: SUCCESS (11.123s) [193.048720] Subtest flip-vs-suspend-interruptible: SUCCESS (11.125s) [203.180412] [010/156] (811s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt) [203.286411] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt [203.287720] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [203.385085] [011/156] (811s left) gem_ccs (block-copy-uncompressed) [203.421814] Starting subtest: block-copy-uncompressed [203.422508] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem [203.441457] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s) [203.448197] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem [203.458662] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s) [203.459375] Subtest block-copy-uncompressed: SUCCESS (0.039s) [203.573774] [012/156] (811s left) kms_lease (lessee-list) [203.659934] Starting subtest: lessee-list [203.660610] Starting dynamic subtest: pipe-A-HDMI-A-1 [203.661376] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [203.671244] Starting dynamic subtest: pipe-B-HDMI-A-1 [203.672009] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [203.679797] Starting dynamic subtest: pipe-C-HDMI-A-1 [203.680503] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [203.687354] Starting dynamic subtest: pipe-D-HDMI-A-1 [203.688029] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [203.688657] Subtest lessee-list: SUCCESS (0.008s) [203.727103] [013/156] (811s left) gem_exec_basic (basic) [203.765032] Starting subtest: basic [203.765721] Starting dynamic subtest: rcs0-smem [203.766423] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [203.773853] Starting dynamic subtest: bcs0-smem [203.774559] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [203.781629] Starting dynamic subtest: vcs0-smem [203.782316] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [203.788577] Starting dynamic subtest: vcs1-smem [203.789251] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [203.795382] Starting dynamic subtest: vecs0-smem [203.796059] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [203.796716] Subtest basic: SUCCESS (0.004s) [203.954245] [014/156] (811s left) syncobj_timeline (wait-all-delayed-signal) [203.986696] Starting subtest: wait-all-delayed-signal [204.089527] Subtest wait-all-delayed-signal: SUCCESS (0.105s) [204.175005] [015/156] (811s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [204.261971] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [204.263436] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s) [204.321578] [016/156] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [204.412700] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu [204.414126] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [204.515195] [017/156] (810s left) kms_rotation_crc (primary-rotation-90) [204.601711] Starting subtest: primary-rotation-90 [209.572491] Subtest primary-rotation-90: SUCCESS (5.047s) [209.776935] [018/156] (805s left) kms_tiled_display (basic-test-pattern) [209.903759] Subtest basic-test-pattern: SKIP (0.000s) [209.944760] [019/156] (805s left) kms_flip (basic-flip-vs-wf_vblank) [210.032943] Starting subtest: basic-flip-vs-wf_vblank [210.034679] Starting dynamic subtest: A-HDMI-A1 [210.928020] Dynamic subtest A-HDMI-A1: SUCCESS (0.901s) [210.938830] Starting dynamic subtest: B-HDMI-A1 [211.826244] Dynamic subtest B-HDMI-A1: SUCCESS (0.900s) [211.834374] Starting dynamic subtest: C-HDMI-A1 [212.712705] Dynamic subtest C-HDMI-A1: SUCCESS (0.891s) [212.723382] Starting dynamic subtest: D-HDMI-A1 [213.598039] Dynamic subtest D-HDMI-A1: SUCCESS (0.890s) [213.601117] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.597s) [213.754140] [020/156] (801s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt) [213.850755] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt [213.852100] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [213.935832] [021/156] (801s left) perf_pmu (busy-accuracy-50) [213.972379] Starting subtest: busy-accuracy-50 [213.973085] Starting dynamic subtest: rcs0 [215.498610] Dynamic subtest rcs0: SUCCESS (1.531s) [215.507479] Starting dynamic subtest: bcs0 [217.023605] Dynamic subtest bcs0: SUCCESS (1.533s) [217.033134] Starting dynamic subtest: vcs0 [218.549108] Dynamic subtest vcs0: SUCCESS (1.528s) [218.557353] Starting dynamic subtest: vcs1 [220.072687] Dynamic subtest vcs1: SUCCESS (1.528s) [220.081977] Starting dynamic subtest: vecs0 [221.597211] Dynamic subtest vecs0: SUCCESS (1.528s) [221.598360] Subtest busy-accuracy-50: SUCCESS (7.651s) [221.683158] [022/156] (793s left) kms_cursor_edge_walk (64x64-top-bottom) [221.776157] Starting subtest: 64x64-top-bottom [221.776910] Starting dynamic subtest: pipe-A-HDMI-A-1 [223.524004] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.750s) [223.534396] Starting dynamic subtest: pipe-D-HDMI-A-1 [225.220215] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.698s) [225.221266] Subtest 64x64-top-bottom: SUCCESS (3.451s) [225.335917] [023/156] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [225.439439] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [225.440863] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [225.539528] [024/156] (790s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-pwrite) [225.632691] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-pwrite [225.634104] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [225.728267] [025/156] (789s left) gem_softpin (evict-prime-sanity-check) [225.765845] Starting subtest: evict-prime-sanity-check [225.766574] Starting dynamic subtest: rcs0 [226.884185] Dynamic subtest rcs0: SUCCESS (1.119s) [226.903350] Starting dynamic subtest: bcs0 [227.989704] Dynamic subtest bcs0: SUCCESS (1.105s) [228.002271] Starting dynamic subtest: vcs0 [229.111185] Dynamic subtest vcs0: SUCCESS (1.121s) [229.131068] Starting dynamic subtest: vcs1 [230.236083] Dynamic subtest vcs1: SUCCESS (1.124s) [230.247706] Starting dynamic subtest: vecs0 [231.357086] Dynamic subtest vecs0: SUCCESS (1.120s) [231.367818] Starting dynamic subtest: all [232.477118] Dynamic subtest all: SUCCESS (1.119s) [232.478513] Subtest evict-prime-sanity-check: SUCCESS (6.717s) [232.569081] [026/156] (783s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary) [232.667671] Starting subtest: psrhdr-indfb-scaledprimary [232.669084] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s) [232.766398] [027/156] (782s left) gem_exec_whisper (basic-forked) [232.809872] Starting subtest: basic-forked [234.469518] Subtest basic-forked: SUCCESS (1.660s) [234.671814] [028/156] (781s left) gem_exec_reloc (basic-gtt-read-active) [234.709790] Starting subtest: basic-gtt-read-active [234.842420] Subtest basic-gtt-read-active: SUCCESS (0.124s) [234.953196] [029/156] (780s left) kms_async_flips (test-time-stamp-atomic) [235.041916] Starting subtest: test-time-stamp-atomic [235.165565] Starting dynamic subtest: pipe-A-HDMI-A-1 [235.279717] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.113s) [235.405104] Starting dynamic subtest: pipe-B-HDMI-A-1 [235.487782] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.089s) [235.618215] Starting dynamic subtest: pipe-C-HDMI-A-1 [235.713099] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.102s) [235.829896] Starting dynamic subtest: pipe-D-HDMI-A-1 [235.928737] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.107s) [235.929501] Subtest test-time-stamp-atomic: SUCCESS (0.888s) [236.166379] [030/156] (779s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt) [236.267674] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt [236.269049] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [236.352002] [031/156] (779s left) gem_vm_create (invalid-create) [236.389049] Starting subtest: invalid-create [236.389797] Subtest invalid-create: SUCCESS (0.001s) [236.478253] [032/156] (779s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-blt) [236.571832] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-blt [236.573310] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [236.673493] [033/156] (779s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [236.764098] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [247.622261] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.862s) [247.792620] [034/156] (768s left) kms_cursor_crc (cursor-offscreen-128x42) [247.897065] Starting subtest: cursor-offscreen-128x42 [247.901522] Starting dynamic subtest: pipe-A-HDMI-A-1 [249.140797] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.240s) [249.190083] Starting dynamic subtest: pipe-D-HDMI-A-1 [250.405149] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.225s) [250.406065] Subtest cursor-offscreen-128x42: SUCCESS (2.510s) [250.586641] [035/156] (765s left) kms_chamelium_audio (hdmi-audio-edid) [250.733874] Subtest hdmi-audio-edid: SKIP (0.000s) [250.836412] [036/156] (765s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [250.934888] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [250.936349] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [251.022424] [037/156] (765s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [251.115351] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [251.117594] Starting dynamic subtest: pipe-A-HDMI-A-1 [251.124315] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s) [251.132596] Starting dynamic subtest: pipe-B-HDMI-A-1 [251.138954] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s) [251.147107] Starting dynamic subtest: pipe-C-HDMI-A-1 [251.153345] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [251.161030] Starting dynamic subtest: pipe-D-HDMI-A-1 [251.167007] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [251.167689] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SUCCESS (0.013s) [251.375206] [038/156] (764s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [251.472970] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [251.474375] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [251.578703] [039/156] (764s left) kms_lease (cursor-implicit-plane) [251.670400] Starting subtest: cursor-implicit-plane [251.672351] Starting dynamic subtest: pipe-A-HDMI-A-1 [251.855117] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.183s) [251.865998] Starting dynamic subtest: pipe-B-HDMI-A-1 [252.015330] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.158s) [252.025449] Starting dynamic subtest: pipe-C-HDMI-A-1 [252.177844] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.161s) [252.189442] Starting dynamic subtest: pipe-D-HDMI-A-1 [252.343847] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.164s) [252.345706] Subtest cursor-implicit-plane: SUCCESS (0.674s) [252.469791] [040/156] (763s left) kms_pm_rpm (basic-rte) [252.505103] Starting subtest: basic-rte [255.193916] Subtest basic-rte: SUCCESS (2.689s) [256.585101] [041/156] (759s left) gem_mmap_gtt (hang-busy) [256.620613] Starting subtest: hang-busy [292.362420] Subtest hang-busy: SUCCESS (35.745s) [292.453067] [042/156] (723s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [292.544385] Starting subtest: plane-downscale-factor-0-5-with-modifiers [292.545095] Starting dynamic subtest: pipe-A [293.010652] Dynamic subtest pipe-A: SUCCESS (0.466s) [293.024853] Starting dynamic subtest: pipe-B [293.452398] Dynamic subtest pipe-B: SUCCESS (0.441s) [293.462320] Starting dynamic subtest: pipe-C [293.896177] Dynamic subtest pipe-C: SUCCESS (0.443s) [293.910874] Starting dynamic subtest: pipe-D [294.339080] Dynamic subtest pipe-D: SUCCESS (0.442s) [294.339843] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (1.796s) [294.527811] [043/156] (721s left) syncobj_timeline (multi-wait-submitted-signaled) [294.565512] Starting subtest: multi-wait-submitted-signaled [294.566244] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [294.625433] [044/156] (721s left) i915_drm_fdinfo (most-busy-idle-check-all) [294.662844] Starting subtest: most-busy-idle-check-all [294.663623] Starting dynamic subtest: rcs0 [295.305569] Dynamic subtest rcs0: SUCCESS (0.641s) [295.319028] Starting dynamic subtest: bcs0 [295.938018] Dynamic subtest bcs0: SUCCESS (0.630s) [295.950809] Starting dynamic subtest: vcs0 [296.571271] Dynamic subtest vcs0: SUCCESS (0.629s) [296.582049] Starting dynamic subtest: vcs1 [297.200947] Dynamic subtest vcs1: SUCCESS (0.628s) [297.215291] Starting dynamic subtest: vecs0 [297.833882] Dynamic subtest vecs0: SUCCESS (0.631s) [297.837457] Subtest most-busy-idle-check-all: SUCCESS (3.172s) [297.900138] [045/156] (718s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite) [297.996729] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite [297.998233] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [298.083955] [046/156] (718s left) gem_mmap_gtt (basic-wc) [298.117765] Starting subtest: basic-wc [298.755619] Subtest basic-wc: SUCCESS (0.630s) [298.853013] [047/156] (717s left) gem_lmem_evict (dontneed-evict-race) [298.890265] Subtest dontneed-evict-race: SKIP (0.000s) [298.928510] [048/156] (717s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [298.963366] Starting subtest: multi-wait-for-submit-submitted-signaled [298.964271] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [299.027911] [049/156] (717s left) kms_psr (fbc-pr-sprite-blt) [299.121322] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [299.163569] [050/156] (717s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [299.266040] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [299.267441] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [299.351283] [051/156] (717s left) gem_exec_schedule (smoketest) [299.522331] Starting subtest: smoketest [299.523146] Starting dynamic subtest: rcs0 [304.986959] Dynamic subtest rcs0: SUCCESS (5.424s) [304.997397] Starting dynamic subtest: bcs0 [310.385769] Dynamic subtest bcs0: SUCCESS (5.424s) [310.395582] Starting dynamic subtest: vcs0 [315.837501] Dynamic subtest vcs0: SUCCESS (5.425s) [315.847618] Starting dynamic subtest: vcs1 [321.259232] Dynamic subtest vcs1: SUCCESS (5.420s) [321.269049] Starting dynamic subtest: vecs0 [326.680422] Dynamic subtest vecs0: SUCCESS (5.419s) [326.681344] Subtest smoketest: SUCCESS (27.118s) [326.818826] [052/156] (689s left) gem_render_copy (yf-tiled) [326.858936] Starting subtest: yf-tiled [326.859701] Starting dynamic subtest: smem [326.928935] Dynamic subtest smem: SUCCESS (0.069s) [326.929651] Subtest yf-tiled: SUCCESS (0.070s) [327.107691] [053/156] (689s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [327.201310] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [327.202694] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s) [327.255363] [054/156] (689s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [327.348901] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [327.350351] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [327.447484] [055/156] (689s left) core_auth (basic-auth) [327.482645] Starting subtest: basic-auth [327.484463] Subtest basic-auth: SUCCESS (0.001s) [327.555243] [056/156] (689s left) kms_hdmi_inject (inject-4k) [327.638586] Starting subtest: inject-4k [327.859043] Subtest inject-4k: SUCCESS (0.221s) [328.000490] [057/156] (688s left) gen3_mixed_blits [328.077611] [058/156] (688s left) kms_prop_blob (blob-prop-validate) [328.118051] Starting subtest: blob-prop-validate [328.118736] Subtest blob-prop-validate: SUCCESS (0.000s) [328.204362] [059/156] (688s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [328.298067] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [329.414893] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (1.117s) [329.540463] [060/156] (687s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [329.640945] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [329.642380] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [329.735448] [061/156] (687s left) kms_frontbuffer_tracking (psr-1p-rte) [329.829770] Starting subtest: psr-1p-rte [329.831170] Subtest psr-1p-rte: SKIP (0.000s) [329.927270] [062/156] (687s left) kms_big_fb (y-tiled-16bpp-rotate-0) [330.027660] Starting subtest: y-tiled-16bpp-rotate-0 [331.181866] Subtest y-tiled-16bpp-rotate-0: SUCCESS (1.154s) [331.319604] [063/156] (685s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [331.412323] Starting subtest: primary-y-tiled-reflect-x-180 [336.429503] Subtest primary-y-tiled-reflect-x-180: SUCCESS (5.017s) [336.632542] [064/156] (680s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt) [336.729850] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt [336.731239] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [336.831354] [065/156] (680s left) kms_chamelium_edid (vga-edid-read) [336.969282] Subtest vga-edid-read: SKIP (0.000s) [337.068508] [066/156] (680s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [337.111651] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [337.112403] Starting dynamic subtest: smem [337.219808] Dynamic subtest smem: SUCCESS (0.107s) [337.220580] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.109s) [337.407963] [067/156] (679s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [337.497401] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [337.498114] Starting dynamic subtest: pipe-A-HDMI-A-1 [337.504206] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [337.512878] Starting dynamic subtest: pipe-B-HDMI-A-1 [337.519212] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [337.527478] Starting dynamic subtest: pipe-C-HDMI-A-1 [337.533431] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [337.541589] Starting dynamic subtest: pipe-D-HDMI-A-1 [337.547473] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s) [337.548149] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.009s) [337.755855] [068/156] (679s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [337.851642] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [337.853088] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [337.949939] [069/156] (679s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [338.045420] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [338.046841] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [338.143024] [070/156] (679s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [338.234467] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [338.235160] Starting dynamic subtest: pipe-A-valid-mode [339.023028] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.787s) [339.023811] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.788s) [339.177692] [071/156] (678s left) kms_psr (psr-suspend) [339.274230] Subtest psr-suspend: SKIP (0.000s) [339.317661] [072/156] (678s left) gem_mmap_wc (bad-offset) [339.352420] Starting subtest: bad-offset [339.353167] Subtest bad-offset: SUCCESS (0.000s) [339.437422] [073/156] (678s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt) [339.530753] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt [339.532291] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [339.626154] [074/156] (677s left) kms_flip (wf_vblank-ts-check) [339.717103] Starting subtest: wf_vblank-ts-check [339.718905] Starting dynamic subtest: A-HDMI-A1 [347.560129] Dynamic subtest A-HDMI-A1: SUCCESS (7.823s) [347.568584] Starting dynamic subtest: B-HDMI-A1 [355.383358] Dynamic subtest B-HDMI-A1: SUCCESS (7.811s) [355.391166] Starting dynamic subtest: C-HDMI-A1 [363.183546] Dynamic subtest C-HDMI-A1: SUCCESS (7.798s) [363.191438] Starting dynamic subtest: D-HDMI-A1 [370.970496] Dynamic subtest D-HDMI-A1: SUCCESS (7.807s) [370.971201] Subtest wf_vblank-ts-check: SUCCESS (31.254s) [371.162585] [075/156] (646s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [371.254361] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [371.256224] Starting dynamic subtest: pipe-A-HDMI-A-1 [371.263414] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [371.272238] Starting dynamic subtest: pipe-B-HDMI-A-1 [371.279341] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [371.287755] Starting dynamic subtest: pipe-C-HDMI-A-1 [371.294733] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [371.303124] Starting dynamic subtest: pipe-D-HDMI-A-1 [371.310367] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [371.311755] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s) [371.520450] [076/156] (646s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [371.618437] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [371.619928] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [371.704715] [077/156] (645s left) kms_plane_multiple (tiling-4) [371.795446] Starting subtest: tiling-4 [371.796949] Subtest tiling-4: SKIP (0.000s) [371.853025] [078/156] (645s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [371.953226] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [371.954734] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [372.057434] [079/156] (645s left) i915_query (engine-info-invalid) [372.091660] Starting subtest: engine-info-invalid [372.092429] Subtest engine-info-invalid: SUCCESS (0.000s) [372.156945] [080/156] (645s left) gem_exec_params (invalid-fence-in) [372.194245] Starting subtest: invalid-fence-in [372.195048] Subtest invalid-fence-in: SUCCESS (0.000s) [372.287461] [081/156] (645s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt) [372.383122] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt [372.384551] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [372.483075] [082/156] (645s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [372.574431] Starting subtest: 2x-flip-vs-absolute-wf_vblank [372.583045] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.009s) [372.671475] [083/156] (645s left) kms_addfb_basic (bad-pitch-65536) [372.705434] Starting subtest: bad-pitch-65536 [372.706203] Subtest bad-pitch-65536: SUCCESS (0.000s) [372.865611] [084/156] (645s left) gem_ctx_freq (sysfs) [372.904365] Starting subtest: sysfs [372.905090] Starting dynamic subtest: gt0 [377.867532] Dynamic subtest gt0: SUCCESS (4.963s) [377.870613] Subtest sysfs: SUCCESS (4.965s) [377.944193] [085/156] (640s left) kms_content_protection (legacy-hdcp14) [378.040571] Starting subtest: legacy-hdcp14 [378.047488] Subtest legacy-hdcp14: SKIP (0.004s) [378.157426] [086/156] (639s left) i915_pm_rpm (gem-execbuf) [379.558819] Starting subtest: gem-execbuf [379.560038] Starting dynamic subtest: smem0 [383.361764] Dynamic subtest smem0: SUCCESS (3.804s) [383.365193] Subtest gem-execbuf: SUCCESS (3.808s) [383.558682] [087/156] (634s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [383.659483] Starting subtest: yf-tiled-16bpp-rotate-90 [383.660895] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [383.756831] [088/156] (634s left) kms_big_fb (x-tiled-8bpp-rotate-0) [383.856096] Starting subtest: x-tiled-8bpp-rotate-0 [384.872619] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.016s) [385.011082] [089/156] (633s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [385.104254] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [385.147347] [090/156] (633s left) gem_exec_balancer (invalid-balancer) [385.190274] Starting subtest: invalid-balancer [386.496493] Subtest invalid-balancer: SUCCESS (1.298s) [386.681227] [091/156] (631s left) gem_fenced_exec_thrash (no-spare-fences) [386.718665] Starting subtest: no-spare-fences [388.875407] Subtest no-spare-fences: SUCCESS (2.154s) [388.987206] [092/156] (629s left) syncobj_timeline (invalid-query-zero-handles) [389.023572] Starting subtest: invalid-query-zero-handles [389.024348] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [389.088693] [093/156] (629s left) gem_render_copy (linear) [389.129109] Starting subtest: linear [389.129794] Starting dynamic subtest: smem [389.191655] Dynamic subtest smem: SUCCESS (0.063s) [389.192451] Subtest linear: SUCCESS (0.064s) [389.377179] [094/156] (628s left) gem_ctx_persistence (heartbeat-close) [389.415005] Starting subtest: heartbeat-close [389.643997] Subtest heartbeat-close: SUCCESS (0.228s) [389.709751] [095/156] (628s left) gem_ctx_shared (exec-shared-gtt) [389.751906] Starting subtest: exec-shared-gtt [389.752701] Starting dynamic subtest: rcs0 [389.756153] Dynamic subtest rcs0: SUCCESS (0.004s) [389.766827] Starting dynamic subtest: bcs0 [389.767547] Dynamic subtest bcs0: SUCCESS (0.003s) [389.776407] Starting dynamic subtest: vcs0 [389.777113] Dynamic subtest vcs0: SUCCESS (0.003s) [389.785500] Starting dynamic subtest: vcs1 [389.786217] Dynamic subtest vcs1: SUCCESS (0.003s) [389.794848] Starting dynamic subtest: vecs0 [389.795571] Dynamic subtest vecs0: SUCCESS (0.003s) [389.796259] Subtest exec-shared-gtt: SUCCESS (0.021s) [389.954505] [096/156] (628s left) kms_frontbuffer_tracking (hdr-farfromfence-mmap-gtt) [390.050724] Starting subtest: hdr-farfromfence-mmap-gtt [390.052121] Subtest hdr-farfromfence-mmap-gtt: SKIP (0.000s) [390.154306] [097/156] (628s left) kms_psr (psr2-sprite-blt) [390.250060] Subtest psr2-sprite-blt: SKIP (0.000s) [390.294935] [098/156] (628s left) kms_force_connector_basic (force-edid) [390.421073] Starting subtest: force-edid [390.572187] Subtest force-edid: SUCCESS (0.151s) [390.734298] [099/156] (627s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt) [390.830837] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt [390.832233] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [390.903527] [100/156] (627s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [390.997722] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [390.999105] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [391.082929] [101/156] (627s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [391.118591] Starting subtest: invalid-multi-wait-all-unsubmitted [391.119331] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [391.193116] [102/156] (627s left) gem_exec_reloc (basic-scanout) [391.290239] Starting subtest: basic-scanout [391.290984] Starting dynamic subtest: rcs0 [391.448194] Dynamic subtest rcs0: SUCCESS (0.157s) [391.462355] Starting dynamic subtest: bcs0 [391.564346] Dynamic subtest bcs0: SUCCESS (0.114s) [391.582248] Starting dynamic subtest: vcs0 [391.689602] Dynamic subtest vcs0: SUCCESS (0.123s) [391.707956] Starting dynamic subtest: vcs1 [391.814461] Dynamic subtest vcs1: SUCCESS (0.123s) [391.831807] Starting dynamic subtest: vecs0 [391.939771] Dynamic subtest vecs0: SUCCESS (0.124s) [391.940846] Subtest basic-scanout: SUCCESS (0.651s) [392.049508] [103/156] (626s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move) [392.143784] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move [392.145203] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [392.235659] [104/156] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [392.329357] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [392.330802] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [392.427220] [105/156] (626s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [392.519862] Starting subtest: psr-rgb565-draw-mmap-gtt [392.521291] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [392.606731] [106/156] (626s left) gem_lmem_swapping (verify-random-ccs) [392.645225] Subtest verify-random-ccs: SKIP (0.000s) [392.685374] [107/156] (626s left) gem_mmap_gtt (big-copy-odd) [392.719212] Starting subtest: big-copy-odd [399.976047] Subtest big-copy-odd: SUCCESS (7.257s) [400.052672] [108/156] (618s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [400.148595] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [400.253072] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s) [400.328424] [109/156] (618s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite) [400.430564] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite [400.432037] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [400.520398] [110/156] (618s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [400.611457] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [400.612184] Starting dynamic subtest: pipe-A-HDMI-A-1 [400.629694] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s) [400.638936] Starting dynamic subtest: pipe-B-HDMI-A-1 [400.656920] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s) [400.665750] Starting dynamic subtest: pipe-C-HDMI-A-1 [400.683363] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [400.694020] Starting dynamic subtest: pipe-D-HDMI-A-1 [400.712378] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s) [400.713746] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.013s) [400.872297] [111/156] (618s left) gen9_exec_parse (batch-without-end) [400.913816] Subtest batch-without-end: SKIP (0.000s) [400.957176] [112/156] (618s left) kms_dsc (dsc-fractional-bpp-bigjoiner) [401.047021] Starting subtest: dsc-fractional-bpp-bigjoiner [401.048566] Subtest dsc-fractional-bpp-bigjoiner: SKIP (0.000s) [401.104053] [113/156] (617s left) kms_invalid_mode (bad-vsync-end) [401.195138] Starting subtest: bad-vsync-end [401.195843] Starting dynamic subtest: pipe-A-HDMI-A-1 [401.246409] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.051s) [401.257647] Starting dynamic subtest: pipe-B-HDMI-A-1 [401.258383] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [401.267621] Starting dynamic subtest: pipe-C-HDMI-A-1 [401.268373] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [401.277320] Starting dynamic subtest: pipe-D-HDMI-A-1 [401.278030] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [401.278719] Subtest bad-vsync-end: SUCCESS (0.065s) [401.411258] [114/156] (617s left) kms_psr (fbc-psr-primary-mmap-gtt) [401.502965] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s) [401.547602] [115/156] (617s left) syncobj_basic (bad-destroy) [401.582546] Starting subtest: bad-destroy [401.583306] Subtest bad-destroy: SUCCESS (0.000s) [401.645547] [116/156] (617s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [401.739072] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [401.740467] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [401.847547] [117/156] (617s left) kms_chamelium_hpd (hdmi-hpd) [401.995793] Subtest hdmi-hpd: SKIP (0.000s) [402.098392] [118/156] (617s left) kms_flip (flip-vs-modeset-vs-hang) [402.190888] Starting subtest: flip-vs-modeset-vs-hang [402.192747] Starting dynamic subtest: A-HDMI-A1 [430.577793] Dynamic subtest A-HDMI-A1: SUCCESS (28.379s) [430.586399] Starting dynamic subtest: D-HDMI-A1 [458.765422] Dynamic subtest D-HDMI-A1: SUCCESS (28.156s) [458.766413] Subtest flip-vs-modeset-vs-hang: SUCCESS (56.541s) [458.892080] [119/156] (560s left) gem_create (create-ext-cpu-access-big) [459.056656] Starting subtest: create-ext-cpu-access-big [459.059098] Subtest create-ext-cpu-access-big: SKIP (0.001s) [459.110074] [120/156] (560s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4) [459.207718] Starting subtest: fbcpsrhdr-tiling-4 [459.209113] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s) [459.308940] [121/156] (560s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [459.403802] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [459.405223] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [459.510187] [122/156] (559s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [459.600377] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s) [459.646941] [123/156] (559s left) kms_plane_scaling (planes-upscale-factor-0-25) [459.740398] Starting subtest: planes-upscale-factor-0-25 [459.741095] Starting dynamic subtest: pipe-A [459.802915] Dynamic subtest pipe-A: SUCCESS (0.063s) [459.816148] Starting dynamic subtest: pipe-B [459.954110] Dynamic subtest pipe-B: SUCCESS (0.150s) [459.966168] Starting dynamic subtest: pipe-C [460.095630] Dynamic subtest pipe-C: SUCCESS (0.140s) [460.109504] Starting dynamic subtest: pipe-D [460.230886] Dynamic subtest pipe-D: SUCCESS (0.134s) [460.231641] Subtest planes-upscale-factor-0-25: SUCCESS (0.492s) [460.426404] [124/156] (559s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc) [460.523096] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc [460.524537] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [460.610916] [125/156] (558s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [460.700399] Starting subtest: cursorA-vs-flipB-toggle [460.702874] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [460.759447] [126/156] (558s left) i915_hangman (engine-engine-hang) [460.804403] Starting subtest: engine-engine-hang [460.805133] Starting dynamic subtest: rcs0 [461.373175] Dynamic subtest rcs0: SUCCESS (0.569s) [461.387400] Starting dynamic subtest: bcs0 [461.963245] Dynamic subtest bcs0: SUCCESS (0.588s) [461.978072] Starting dynamic subtest: vcs0 [462.541097] Dynamic subtest vcs0: SUCCESS (0.575s) [462.555915] Starting dynamic subtest: vcs1 [463.129379] Dynamic subtest vcs1: SUCCESS (0.586s) [463.144829] Starting dynamic subtest: vecs0 [463.701144] Dynamic subtest vecs0: SUCCESS (0.569s) [463.702462] Subtest engine-engine-hang: SUCCESS (2.898s) [463.773746] [127/156] (555s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-pwrite) [463.869762] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-pwrite [463.871171] Subtest fbchdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [463.971744] [128/156] (555s left) gem_exec_fence (syncobj-timeline-invalid-wait) [464.474687] Starting subtest: syncobj-timeline-invalid-wait [464.475643] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s) [464.646143] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true [464.649273] [129/156] (555s left) kms_cursor_legacy (torture-bo) [464.743466] Starting subtest: torture-bo [464.744246] Starting dynamic subtest: pipe-A [470.283838] Dynamic subtest pipe-A: SUCCESS (5.505s) [470.301360] Starting dynamic subtest: pipe-B [475.861620] Dynamic subtest pipe-B: SUCCESS (5.577s) [475.883203] Starting dynamic subtest: pipe-C [481.367600] Dynamic subtest pipe-C: SUCCESS (5.504s) [481.379404] Starting dynamic subtest: pipe-D [486.843170] Dynamic subtest pipe-D: SUCCESS (5.475s) [486.854686] Starting dynamic subtest: all-pipes [492.326517] Dynamic subtest all-pipes: SUCCESS (5.482s) [492.327520] Subtest torture-bo: SUCCESS (27.549s) [492.386928] [130/156] (527s left) perf_pmu (most-busy-check-all) [492.425732] Starting subtest: most-busy-check-all [492.426619] Starting dynamic subtest: rcs0 [492.946692] Dynamic subtest rcs0: SUCCESS (0.520s) [492.959906] Starting dynamic subtest: bcs0 [493.473802] Dynamic subtest bcs0: SUCCESS (0.525s) [493.487118] Starting dynamic subtest: vcs0 [494.000534] Dynamic subtest vcs0: SUCCESS (0.525s) [494.013523] Starting dynamic subtest: vcs1 [494.520056] Dynamic subtest vcs1: SUCCESS (0.516s) [494.532468] Starting dynamic subtest: vecs0 [495.041472] Dynamic subtest vecs0: SUCCESS (0.518s) [495.042590] Subtest most-busy-check-all: SUCCESS (2.615s) [495.117521] [131/156] (524s left) kms_psr (psr2-primary-mmap-gtt) [495.207826] Subtest psr2-primary-mmap-gtt: SKIP (0.000s) [495.254446] [132/156] (524s left) syncobj_wait (single-wait-all-signaled) [495.288722] Starting subtest: single-wait-all-signaled [495.289451] Subtest single-wait-all-signaled: SUCCESS (0.000s) [495.358840] [133/156] (524s left) kms_addfb_basic (size-max) [495.452400] Starting subtest: size-max [495.453180] Subtest size-max: SUCCESS (0.000s) [495.536480] [134/156] (524s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [495.631069] Starting subtest: fbc-modesetfrombusy [496.292318] Subtest fbc-modesetfrombusy: SUCCESS (0.661s) [496.417409] [135/156] (523s left) sw_sync (sync_busy_fork_unixsocket) [496.452027] Starting subtest: sync_busy_fork_unixsocket [496.461225] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s) [496.519439] [136/156] (523s left) perf (whitelisted-registers-userspace-config) [496.614246] Starting subtest: whitelisted-registers-userspace-config [496.614999] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s) [496.663187] [137/156] (523s left) gem_basic (create-fd-close) [496.698106] Starting subtest: create-fd-close [496.699556] Subtest create-fd-close: SUCCESS (0.000s) [496.783195] [138/156] (523s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [496.880051] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu [496.881523] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [496.985219] [139/156] (523s left) kms_plane (pixel-format-y-tiled-modifier) [497.075351] Starting subtest: pixel-format-y-tiled-modifier [497.092693] Starting dynamic subtest: pipe-A-plane-0 [497.384224] Dynamic subtest pipe-A-plane-0: SUCCESS (0.291s) [497.402757] Starting dynamic subtest: pipe-A-plane-3 [497.617619] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s) [497.635231] Starting dynamic subtest: pipe-A-plane-5 [497.859439] Dynamic subtest pipe-A-plane-5: SUCCESS (0.240s) [497.878295] Starting dynamic subtest: pipe-A-plane-7 [497.879705] Dynamic subtest pipe-A-plane-7: SKIP (0.000s) [498.019251] Starting dynamic subtest: pipe-B-plane-0 [498.260585] Dynamic subtest pipe-B-plane-0: SUCCESS (0.250s) [498.279754] Starting dynamic subtest: pipe-B-plane-3 [498.493977] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s) [498.511225] Starting dynamic subtest: pipe-B-plane-5 [498.735680] Dynamic subtest pipe-B-plane-5: SUCCESS (0.238s) [498.752368] Starting dynamic subtest: pipe-B-plane-7 [498.753935] Dynamic subtest pipe-B-plane-7: SKIP (0.000s) [498.784136] Subtest pixel-format-y-tiled-modifier: SUCCESS (1.708s) [498.957922] [140/156] (521s left) prime_vgem (basic-gtt) [499.019925] Starting subtest: basic-gtt [499.033488] Subtest basic-gtt: SUCCESS (0.014s) [499.131195] [141/156] (521s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [499.166617] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [499.167393] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [499.247110] [142/156] (520s left) syncobj_timeline (invalid-signal-illegal-point) [499.282819] Starting subtest: invalid-signal-illegal-point [499.283577] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [499.351164] [143/156] (520s left) gem_wait (invalid-flags) [499.388651] Starting subtest: invalid-flags [499.389386] Subtest invalid-flags: SUCCESS (0.000s) [499.609568] [144/156] (520s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [499.704653] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [499.706197] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [499.828131] [145/156] (520s left) device_reset (unbind-reset-rebind) [499.879394] Starting subtest: unbind-reset-rebind [502.056954] Subtest unbind-reset-rebind: SUCCESS (2.174s) [502.093240] [146/156] (518s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [502.139403] Starting subtest: y-tiled-ccs-to-x-tiled [502.140219] Starting dynamic subtest: smem [502.251570] Dynamic subtest smem: SUCCESS (0.112s) [502.252356] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.113s) [502.419120] [147/156] (518s left) gem_userptr_blits (map-fixed-invalidate-busy) [502.465852] Starting subtest: map-fixed-invalidate-busy [502.466640] Starting dynamic subtest: gtt [504.219863] Dynamic subtest gtt: SUCCESS (1.745s) [504.229703] Starting dynamic subtest: wb [505.785569] Dynamic subtest wb: SUCCESS (1.565s) [505.795586] Starting dynamic subtest: wc [507.330742] Dynamic subtest wc: SUCCESS (1.544s) [507.340612] Starting dynamic subtest: uc [508.868521] Dynamic subtest uc: SUCCESS (1.537s) [508.869282] Subtest map-fixed-invalidate-busy: SUCCESS (6.395s) [508.972079] [148/156] (511s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-wc) [509.067431] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-wc [509.068840] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [509.174330] [149/156] (511s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [509.268063] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [509.269512] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [509.362865] [150/156] (511s left) kms_color (ctm-red-to-blue) [509.452435] Starting subtest: ctm-red-to-blue [509.453131] Starting dynamic subtest: pipe-A-HDMI-A-1 [509.763271] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.311s) [509.773308] Starting dynamic subtest: pipe-B-HDMI-A-1 [510.051047] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.286s) [510.060993] Starting dynamic subtest: pipe-C-HDMI-A-1 [510.345772] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.294s) [510.355554] Starting dynamic subtest: pipe-D-HDMI-A-1 [510.638199] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.291s) [510.638957] Subtest ctm-red-to-blue: SUCCESS (1.186s) [510.771440] [151/156] (509s left) api_intel_bb (reset-flags) [510.807986] Starting subtest: reset-flags [510.812943] Subtest reset-flags: SUCCESS (0.006s) [510.913261] [152/156] (509s left) kms_addfb_basic (invalid-set-prop) [510.947348] Starting subtest: invalid-set-prop [510.948057] Subtest invalid-set-prop: SUCCESS (0.000s) [511.092293] [153/156] (509s left) api_intel_allocator (two-level-inception-interruptible) [511.131858] Starting subtest: two-level-inception-interruptible [516.589158] Subtest two-level-inception-interruptible: SUCCESS (5.423s) [516.654515] [154/156] (504s left) kms_psr (fbc-psr2-cursor-blt) [516.751016] Subtest fbc-psr2-cursor-blt: SKIP (0.000s) [516.793731] [155/156] (504s left) kms_addfb_basic (addfb25-x-tiled-legacy) [516.882727] Starting subtest: addfb25-x-tiled-legacy [516.883499] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [516.993008] [156/156] (503s left) syncobj_eventfd (timeline-wait-before-signal) [517.030090] Starting subtest: timeline-wait-before-signal [517.061221] Subtest timeline-wait-before-signal: SUCCESS (0.032s) [517.136568] Closing watchdogs results: parsing output: 0/ for test: kms_busy results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: gem_exec_schedule results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_flip results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_vrr results: parsing output: 7/ for test: kms_cursor_crc results: parsing output: 8/ for test: kms_flip results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_ccs results: parsing output: 11/ for test: kms_lease results: parsing output: 12/ for test: gem_exec_basic results: parsing output: 13/ for test: syncobj_timeline results: parsing output: 14/ for test: kms_plane results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_rotation_crc results: parsing output: 17/ for test: kms_tiled_display results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: perf_pmu results: parsing output: 21/ for test: kms_cursor_edge_walk results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: gem_softpin results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: gem_exec_whisper results: parsing output: 27/ for test: gem_exec_reloc results: parsing output: 28/ for test: kms_async_flips results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: gem_vm_create results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_cursor_legacy results: parsing output: 33/ for test: kms_cursor_crc results: parsing output: 34/ for test: kms_chamelium_audio results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_lease results: parsing output: 39/ for test: kms_pm_rpm results: parsing output: 40/ for test: gem_mmap_gtt results: parsing output: 41/ for test: kms_plane_scaling results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: i915_drm_fdinfo results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: gem_mmap_gtt results: parsing output: 46/ for test: gem_lmem_evict results: parsing output: 47/ for test: syncobj_wait results: parsing output: 48/ for test: kms_psr results: parsing output: 49/ for test: kms_big_fb results: parsing output: 50/ for test: gem_exec_schedule results: parsing output: 51/ for test: gem_render_copy results: parsing output: 52/ for test: kms_flip_scaled_crc results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: core_auth results: parsing output: 55/ for test: kms_hdmi_inject results: parsing output: 56/ for test: gen3_mixed_blits results: parsing output: 57/ for test: kms_prop_blob results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: kms_rotation_crc results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_chamelium_edid results: parsing output: 65/ for test: gem_render_copy results: parsing output: 66/ for test: kms_ccs results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_flip_scaled_crc results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: gem_mmap_wc results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_flip results: parsing output: 74/ for test: kms_ccs results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_plane_multiple results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: i915_query results: parsing output: 79/ for test: gem_exec_params results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_flip results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: gem_ctx_freq results: parsing output: 84/ for test: kms_content_protection results: parsing output: 85/ for test: i915_pm_rpm results: parsing output: 86/ for test: kms_big_fb results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: kms_psr2_sf results: parsing output: 89/ for test: gem_exec_balancer results: parsing output: 90/ for test: gem_fenced_exec_thrash results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: gem_render_copy results: parsing output: 93/ for test: gem_ctx_persistence results: parsing output: 94/ for test: gem_ctx_shared results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_psr results: parsing output: 97/ for test: kms_force_connector_basic results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: syncobj_wait results: parsing output: 101/ for test: gem_exec_reloc results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_lmem_swapping results: parsing output: 106/ for test: gem_mmap_gtt results: parsing output: 107/ for test: syncobj_timeline results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_ccs results: parsing output: 110/ for test: gen9_exec_parse results: parsing output: 111/ for test: kms_dsc results: parsing output: 112/ for test: kms_invalid_mode results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: syncobj_basic results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_chamelium_hpd results: parsing output: 117/ for test: kms_flip results: parsing output: 118/ for test: gem_create results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_psr2_sf results: parsing output: 122/ for test: kms_plane_scaling results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_cursor_legacy results: parsing output: 125/ for test: i915_hangman results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: gem_exec_fence results: parsing output: 128/ for test: kms_cursor_legacy results: parsing output: 129/ for test: perf_pmu results: parsing output: 130/ for test: kms_psr results: parsing output: 131/ for test: syncobj_wait results: parsing output: 132/ for test: kms_addfb_basic results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: sw_sync results: parsing output: 135/ for test: perf results: parsing output: 136/ for test: gem_basic results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: kms_plane results: parsing output: 139/ for test: prime_vgem results: parsing output: 140/ for test: syncobj_wait results: parsing output: 141/ for test: syncobj_timeline results: parsing output: 142/ for test: gem_wait results: parsing output: 143/ for test: kms_frontbuffer_tracking results: parsing output: 144/ for test: device_reset results: parsing output: 145/ for test: gem_render_copy results: parsing output: 146/ for test: gem_userptr_blits results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_frontbuffer_tracking results: parsing output: 149/ for test: kms_color results: parsing output: 150/ for test: api_intel_bb results: parsing output: 151/ for test: kms_addfb_basic results: parsing output: 152/ for test: api_intel_allocator results: parsing output: 153/ for test: kms_psr results: parsing output: 154/ for test: kms_addfb_basic results: parsing output: 155/ for test: syncobj_eventfd Done.