[63.122879] Initializing watchdogs [63.122944] /dev/watchdog0 [63.141712] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [63.151730] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [63.156172] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [63.158585] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [63.411468] Starting subtest: dp-mst-lic-type-0-hdcp14 [63.413215] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [63.611317] [002/133] (960s left) core_getversion (all-cards) [63.667080] Starting subtest: all-cards [63.695197] Subtest all-cards: SUCCESS (0.029s) [63.746940] [003/133] (960s left) kms_atomic_interruptible (legacy-dpms) [63.923889] Starting subtest: legacy-dpms [63.924779] Starting dynamic subtest: pipe-A-DP-3 [70.264831] Dynamic subtest pipe-A-DP-3: SUCCESS (6.355s) [70.265647] Subtest legacy-dpms: SUCCESS (6.356s) [70.523205] [004/133] (953s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping) [70.700935] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping [70.705896] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [70.852732] [005/133] (953s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [71.029751] Starting subtest: plane-primary-toggle-with-vblank-wait [71.030591] Starting dynamic subtest: pipe-A-DP-3 [71.259680] Dynamic subtest pipe-A-DP-3: SUCCESS (0.228s) [71.394433] Starting dynamic subtest: pipe-B-DP-3 [71.661062] Dynamic subtest pipe-B-DP-3: SUCCESS (0.274s) [71.768107] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.739s) [72.040647] [006/133] (951s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [72.223215] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [72.224852] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [72.406390] [007/133] (951s left) kms_psr (fbc-psr2-primary-mmap-cpu) [72.590166] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s) [72.649955] [008/133] (951s left) perf (invalid-oa-exponent) [73.082283] Starting subtest: invalid-oa-exponent [73.105609] Subtest invalid-oa-exponent: SUCCESS (0.023s) [73.151492] [009/133] (951s left) gem_eio (create-ext) [73.440997] Starting subtest: create-ext [73.942357] Subtest create-ext: SUCCESS (0.502s) [74.176459] [010/133] (950s left) kms_color (invalid-degamma-lut-sizes) [74.358052] Starting subtest: invalid-degamma-lut-sizes [74.358971] Starting dynamic subtest: pipe-A [74.437316] Dynamic subtest pipe-A: SUCCESS (0.080s) [74.447509] Starting dynamic subtest: pipe-B [74.448434] Dynamic subtest pipe-B: SUCCESS (0.001s) [74.457977] Starting dynamic subtest: pipe-C [74.458964] Dynamic subtest pipe-C: SUCCESS (0.001s) [74.467072] Starting dynamic subtest: pipe-D [74.467925] Dynamic subtest pipe-D: SUCCESS (0.001s) [74.468795] Subtest invalid-degamma-lut-sizes: SUCCESS (0.083s) [74.675607] [011/133] (949s left) gem_softpin (allocator-basic) [74.748154] Starting subtest: allocator-basic [74.975225] Subtest allocator-basic: SUCCESS (0.227s) [75.188990] [012/133] (949s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [75.376959] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [75.431595] [013/133] (949s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [75.629206] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [75.630816] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [75.819946] [014/133] (948s left) kms_psr (pr-primary-render) [75.998136] Subtest pr-primary-render: SKIP (0.000s) [76.047529] [015/133] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [76.228374] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [76.230019] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [76.364161] [016/133] (948s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [76.547453] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [76.597187] [017/133] (948s left) gem_ccs (ctrl-surf-copy) [76.672152] Starting subtest: ctrl-surf-copy [76.673061] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0 [76.727884] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.055s) [76.736259] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0 [76.949863] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.221s) [76.958408] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0 [76.978484] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.029s) [76.986738] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0 [77.201258] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.222s) [77.209472] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0 [77.230195] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.029s) [77.238424] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0 [77.449264] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.219s) [77.457438] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0 [77.478194] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.029s) [77.486433] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0 [77.696989] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.218s) [77.697950] Subtest ctrl-surf-copy: SUCCESS (1.025s) [77.883859] [018/133] (946s left) perf (invalid-oa-metric-set-id) [78.122652] Starting subtest: invalid-oa-metric-set-id [78.139089] Subtest invalid-oa-metric-set-id: SUCCESS (0.016s) [78.182536] [019/133] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [78.365334] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [78.366969] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [78.571288] [020/133] (946s left) gem_pxp (create-regular-buffer) [81.167994] Starting subtest: create-regular-buffer [81.170133] Subtest create-regular-buffer: SKIP (0.000s) [81.331546] [021/133] (943s left) gem_eio (in-flight-contexts-10ms) [81.631265] Starting subtest: in-flight-contexts-10ms [94.951114] Subtest in-flight-contexts-10ms: SUCCESS (13.320s) [95.187232] [022/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [95.367325] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [95.369007] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [95.554918] [023/133] (929s left) gem_exec_schedule (u-fairslice-all) [95.635262] Starting subtest: u-fairslice-all [97.753965] Subtest u-fairslice-all: SUCCESS (2.119s) [98.138482] [024/133] (926s left) core_getstats (basic) [98.217036] Starting subtest: basic [98.217919] Subtest basic: SUCCESS (0.000s) [98.388078] [025/133] (926s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [98.562953] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [98.563855] Starting dynamic subtest: pipe-A-DP-3 [98.572221] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [98.581039] Starting dynamic subtest: pipe-B-DP-3 [98.589321] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [98.597990] Starting dynamic subtest: pipe-C-DP-3 [98.606176] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [98.614580] Starting dynamic subtest: pipe-D-DP-3 [98.623825] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [98.625375] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.006s) [99.037620] [026/133] (926s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [99.217860] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [99.218708] Starting dynamic subtest: pipe-A-DP-3 [99.227248] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [99.235983] Starting dynamic subtest: pipe-B-DP-3 [99.244212] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [99.252726] Starting dynamic subtest: pipe-C-DP-3 [99.260914] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [99.269363] Starting dynamic subtest: pipe-D-DP-3 [99.279179] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [99.281536] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s) [99.673634] [027/133] (925s left) sw_sync (alloc_fence) [99.716181] Starting subtest: alloc_fence [99.717147] Subtest alloc_fence: SUCCESS (0.000s) [99.832031] [028/133] (925s left) i915_pm_rps (basic-api) [99.915780] Starting subtest: basic-api [99.917537] Subtest basic-api: SKIP (0.000s) [100.086573] [029/133] (925s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [100.270493] Starting subtest: cursorB-vs-flipA-toggle [100.273252] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s) [100.432145] [030/133] (925s left) kms_cursor_crc (cursor-rapid-movement-128x42) [100.803211] Starting subtest: cursor-rapid-movement-128x42 [100.807265] Starting dynamic subtest: pipe-A-DP-3 [101.262999] Dynamic subtest pipe-A-DP-3: SUCCESS (0.455s) [101.310480] Starting dynamic subtest: pipe-D-DP-3 [101.710551] Dynamic subtest pipe-D-DP-3: SUCCESS (0.408s) [101.711498] Subtest cursor-rapid-movement-128x42: SUCCESS (0.907s) [102.186336] [031/133] (923s left) kms_dp_link_training (non-uhbr-sst) [102.367594] Starting subtest: non-uhbr-sst [104.533574] Subtest non-uhbr-sst: SUCCESS (2.162s) [104.741654] [032/133] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [104.922391] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [104.924028] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [105.082843] [033/133] (920s left) gem_exec_parallel (engines) [105.160601] Starting subtest: engines [105.161536] Starting dynamic subtest: basic [106.736251] Dynamic subtest basic: SUCCESS (1.575s) [106.746158] Starting dynamic subtest: contexts [111.729975] Dynamic subtest contexts: SUCCESS (4.993s) [111.739099] Starting dynamic subtest: fds [117.074281] Dynamic subtest fds: SUCCESS (5.344s) [117.084403] Starting dynamic subtest: userptr [118.551090] Dynamic subtest userptr: SUCCESS (1.476s) [118.552139] Subtest engines: SUCCESS (13.390s) [118.867663] [034/133] (906s left) gem_eio (in-flight-immediate) [119.164055] Starting subtest: in-flight-immediate [124.504367] Subtest in-flight-immediate: SUCCESS (5.340s) [124.791280] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true [124.793008] [035/133] (901s left) prime_mmap (test_forked) [124.868450] Starting subtest: test_forked [124.869424] Starting dynamic subtest: test_forked-smem [124.924291] Dynamic subtest test_forked-smem: SUCCESS (0.056s) [124.933590] Starting dynamic subtest: test_forked-lmem0 [125.123650] Dynamic subtest test_forked-lmem0: SUCCESS (0.199s) [125.124555] Subtest test_forked: SUCCESS (0.255s) [125.313614] [036/133] (900s left) kms_dsc (dsc-with-formats) [125.501483] Starting subtest: dsc-with-formats [125.516976] Subtest dsc-with-formats: SKIP (0.002s) [125.674266] [037/133] (900s left) prime_busy (hang) [125.755108] Starting subtest: hang [125.757075] Starting dynamic subtest: rcs0 [151.478424] Dynamic subtest rcs0: SUCCESS (25.721s) [151.488149] Starting dynamic subtest: bcs0 [158.637602] Dynamic subtest bcs0: SUCCESS (7.157s) [158.647114] Starting dynamic subtest: vcs0 [165.604529] Dynamic subtest vcs0: SUCCESS (6.966s) [165.614092] Starting dynamic subtest: vcs1 [172.653095] Dynamic subtest vcs1: SUCCESS (7.049s) [172.662659] Starting dynamic subtest: vecs0 [179.627973] Dynamic subtest vecs0: SUCCESS (6.973s) [179.637661] Starting dynamic subtest: vecs1 [186.671601] Dynamic subtest vecs1: SUCCESS (7.043s) [186.681212] Starting dynamic subtest: ccs0 [200.501321] Dynamic subtest ccs0: SUCCESS (13.829s) [200.502225] Subtest hang: SUCCESS (74.744s) [200.678661] [038/133] (825s left) kms_vblank (wait-idle) [200.863888] Starting subtest: wait-idle [200.866041] Starting dynamic subtest: pipe-A-DP-3 [203.193065] Dynamic subtest pipe-A-DP-3: SUCCESS (2.328s) [203.220207] Starting dynamic subtest: pipe-D-DP-3 [205.452512] Dynamic subtest pipe-D-DP-3: SUCCESS (2.249s) [205.453425] Subtest wait-idle: SUCCESS (4.589s) [205.736995] [039/133] (820s left) kms_pm_rpm (package-g7) [208.058493] Starting subtest: package-g7 [208.060781] Subtest package-g7: SKIP (0.000s) [208.504575] [040/133] (817s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [208.691218] Starting subtest: flip-vs-cursor-varying-size [220.605477] Subtest flip-vs-cursor-varying-size: SUCCESS (11.914s) [220.913080] [041/133] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [221.104627] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [221.106272] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [221.298044] [042/133] (805s left) syncobj_timeline (single-wait-all-for-submit-signaled) [221.378330] Starting subtest: single-wait-all-for-submit-signaled [221.379254] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [221.583751] [043/133] (804s left) perf (gen12-group-exclusive-stream-ctx-handle) [221.836368] Starting subtest: gen12-group-exclusive-stream-ctx-handle [221.864210] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.027s) [221.917202] [044/133] (804s left) gem_wait (busy) [222.058394] Starting subtest: busy [222.059459] Starting dynamic subtest: all-engines [222.672345] Dynamic subtest all-engines: SUCCESS (0.615s) [222.683515] Starting dynamic subtest: rcs0 [223.212267] Dynamic subtest rcs0: SUCCESS (0.539s) [223.221955] Starting dynamic subtest: bcs0 [223.751401] Dynamic subtest bcs0: SUCCESS (0.539s) [223.760889] Starting dynamic subtest: vcs0 [224.290270] Dynamic subtest vcs0: SUCCESS (0.538s) [224.299952] Starting dynamic subtest: vcs1 [224.829286] Dynamic subtest vcs1: SUCCESS (0.539s) [224.839159] Starting dynamic subtest: vecs0 [225.368255] Dynamic subtest vecs0: SUCCESS (0.538s) [225.377919] Starting dynamic subtest: vecs1 [225.907443] Dynamic subtest vecs1: SUCCESS (0.539s) [225.917163] Starting dynamic subtest: ccs0 [226.446188] Dynamic subtest ccs0: SUCCESS (0.538s) [226.447162] Subtest busy: SUCCESS (4.389s) [226.705045] [045/133] (799s left) gen9_exec_parse (bb-secure) [226.785301] Subtest bb-secure: SKIP (0.000s) [226.864059] [046/133] (799s left) kms_cursor_edge_walk (128x128-right-edge) [227.044881] Starting subtest: 128x128-right-edge [227.047013] Starting dynamic subtest: pipe-A-DP-3 [230.530776] Dynamic subtest pipe-A-DP-3: SUCCESS (3.485s) [230.544492] Starting dynamic subtest: pipe-D-DP-3 [233.899620] Dynamic subtest pipe-D-DP-3: SUCCESS (3.366s) [233.900954] Subtest 128x128-right-edge: SUCCESS (6.854s) [234.190157] [047/133] (792s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [234.381680] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [234.383238] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [234.581359] [048/133] (792s left) prime_mmap (test_forked_cpu_write) [234.659359] Starting subtest: test_forked_cpu_write [234.660279] Starting dynamic subtest: test_forked_cpu_write-smem [234.668054] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s) [234.677677] Starting dynamic subtest: test_forked_cpu_write-lmem0 [234.678470] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.009s) [234.679321] Subtest test_forked_cpu_write: SUCCESS (0.018s) [234.865600] [049/133] (792s left) kms_addfb_basic (small-bo) [235.055983] Starting subtest: small-bo [235.056921] Subtest small-bo: SUCCESS (0.000s) [235.251493] [050/133] (791s left) kms_chamelium_audio (dp-audio) [235.530754] Subtest dp-audio: SKIP (0.000s) [235.690051] [051/133] (791s left) kms_chamelium_edid (hdmi-edid-change-during-suspend) [235.958667] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s) [236.109466] [052/133] (791s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [236.299748] Starting subtest: psr-shrfb-scaledprimary [236.301379] Subtest psr-shrfb-scaledprimary: SKIP (0.000s) [236.500240] [053/133] (790s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [236.693175] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [236.694889] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [236.851721] [054/133] (790s left) perf (i915-ref-count) [236.975707] Starting subtest: i915-ref-count [237.069159] Subtest i915-ref-count: SUCCESS (0.093s) [237.195663] [055/133] (790s left) kms_joiner (invalid-modeset-force-big-joiner) [237.396976] Starting subtest: invalid-modeset-force-big-joiner [237.397897] Starting dynamic subtest: big_joiner_on_last_pipe [237.602247] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.206s) [237.603796] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.207s) [237.894735] [056/133] (789s left) kms_cursor_crc (cursor-alpha-opaque) [238.086063] Starting subtest: cursor-alpha-opaque [238.086959] Starting dynamic subtest: pipe-A-DP-3 [238.710232] Dynamic subtest pipe-A-DP-3: SUCCESS (0.623s) [238.723394] Starting dynamic subtest: pipe-D-DP-3 [239.236949] Dynamic subtest pipe-D-DP-3: SUCCESS (0.524s) [239.237870] Subtest cursor-alpha-opaque: SUCCESS (1.152s) [239.871069] [057/133] (787s left) kms_legacy_colorkey (basic) [240.056537] Starting subtest: basic [240.057417] Starting dynamic subtest: pipe-A [240.121259] Dynamic subtest pipe-A: SUCCESS (0.064s) [240.139181] Starting dynamic subtest: pipe-B [240.140492] Dynamic subtest pipe-B: SUCCESS (0.001s) [240.158560] Starting dynamic subtest: pipe-C [240.159786] Dynamic subtest pipe-C: SUCCESS (0.001s) [240.173701] Starting dynamic subtest: pipe-D [240.174870] Dynamic subtest pipe-D: SUCCESS (0.001s) [240.176104] Subtest basic: SUCCESS (0.070s) [240.259569] [058/133] (787s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip) [240.454330] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip [240.456153] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [240.652298] [059/133] (787s left) kms_addfb_basic (bad-pitch-32) [240.732227] Starting subtest: bad-pitch-32 [240.733130] Subtest bad-pitch-32: SUCCESS (0.000s) [241.034501] [060/133] (786s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [241.120366] Starting subtest: x-tiled-to-vebox-y-tiled [241.122309] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [241.388285] [061/133] (786s left) gem_exec_reloc (basic-range) [241.470278] Subtest basic-range: SKIP (0.000s) [241.546696] [062/133] (786s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [241.739764] Starting subtest: yf-tiled-64bpp-rotate-0 [241.741426] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [241.935843] [063/133] (786s left) syncobj_wait (wait-all-for-submit-snapshot) [242.012284] Starting subtest: wait-all-for-submit-snapshot [242.095182] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [242.293760] [064/133] (785s left) kms_async_flips (invalid-async-flip) [242.479570] Starting subtest: invalid-async-flip [242.708567] Starting dynamic subtest: pipe-A-DP-3 [243.091562] Dynamic subtest pipe-A-DP-3: SUCCESS (0.383s) [243.301120] Starting dynamic subtest: pipe-B-DP-3 [243.458422] Dynamic subtest pipe-B-DP-3: SUCCESS (0.167s) [243.664157] Starting dynamic subtest: pipe-C-DP-3 [243.813962] Dynamic subtest pipe-C-DP-3: SUCCESS (0.160s) [243.996265] Starting dynamic subtest: pipe-D-DP-3 [244.156356] Dynamic subtest pipe-D-DP-3: SUCCESS (0.171s) [244.157360] Subtest invalid-async-flip: SUCCESS (1.677s) [244.662312] [065/133] (783s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [244.861176] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [244.864660] Starting dynamic subtest: A-DP3 [245.794764] Dynamic subtest A-DP3: SUCCESS (0.929s) [245.807424] Starting dynamic subtest: B-DP3 [246.542506] Dynamic subtest B-DP3: SUCCESS (0.746s) [246.563388] Starting dynamic subtest: C-DP3 [247.288455] Dynamic subtest C-DP3: SUCCESS (0.744s) [247.310786] Starting dynamic subtest: D-DP3 [248.030600] Dynamic subtest D-DP3: SUCCESS (0.739s) [248.031461] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.171s) [248.323995] [066/133] (779s left) kms_frontbuffer_tracking (fbc-suspend) [248.514870] Starting subtest: fbc-suspend [290.349926] Subtest fbc-suspend: SUCCESS (10.900s) [290.628938] [067/133] (737s left) syncobj_timeline (invalid-transfer-bad-pad) [290.712442] Starting subtest: invalid-transfer-bad-pad [290.713359] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [290.854516] [068/133] (737s left) kms_big_fb (4-tiled-64bpp-rotate-90) [291.057108] Starting subtest: 4-tiled-64bpp-rotate-90 [291.116582] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.059s) [291.349557] [069/133] (737s left) gem_ctx_persistence (saturated-hostile-nopreempt) [291.434124] Starting subtest: saturated-hostile-nopreempt [291.435069] Starting dynamic subtest: rcs0 [291.536569] Dynamic subtest rcs0: SKIP (0.101s) [291.553849] Starting dynamic subtest: bcs0 [291.556096] Dynamic subtest bcs0: SKIP (0.012s) [291.574541] Starting dynamic subtest: vcs0 [291.576657] Dynamic subtest vcs0: SKIP (0.013s) [291.590549] Starting dynamic subtest: vcs1 [291.592360] Dynamic subtest vcs1: SKIP (0.012s) [291.604411] Starting dynamic subtest: vecs0 [291.606392] Dynamic subtest vecs0: SKIP (0.013s) [291.617919] Starting dynamic subtest: vecs1 [291.619758] Dynamic subtest vecs1: SKIP (0.014s) [291.631434] Starting dynamic subtest: ccs0 [291.633362] Dynamic subtest ccs0: SKIP (0.013s) [291.635172] Subtest saturated-hostile-nopreempt: SKIP (0.187s) [291.773894] [070/133] (736s left) gem_exec_big (single) [291.864095] Starting subtest: single [297.342082] Subtest single: SUCCESS (5.477s) [298.043344] [071/133] (730s left) gem_exec_fence (submit67) [298.302564] Starting subtest: submit67 [298.304363] Subtest submit67: SKIP (0.000s) [299.030055] [072/133] (729s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [299.232817] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [299.234426] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [299.396471] [073/133] (729s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [299.602986] Starting subtest: fbc-rgb101010-draw-mmap-wc [299.604625] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s) [299.748299] [074/133] (728s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [299.935313] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [299.937059] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [300.128542] [075/133] (728s left) i915_drm_fdinfo (busy-idle) [300.197662] Starting subtest: busy-idle [300.198587] Starting dynamic subtest: rcs0 [300.200388] Dynamic subtest rcs0: SKIP (0.000s) [300.212768] Starting dynamic subtest: bcs0 [300.215062] Dynamic subtest bcs0: SKIP (0.000s) [300.227174] Starting dynamic subtest: vcs0 [300.229357] Dynamic subtest vcs0: SKIP (0.000s) [300.241600] Starting dynamic subtest: vcs1 [300.243985] Dynamic subtest vcs1: SKIP (0.000s) [300.255856] Starting dynamic subtest: vecs0 [300.258009] Dynamic subtest vecs0: SKIP (0.000s) [300.269767] Starting dynamic subtest: vecs1 [300.272039] Dynamic subtest vecs1: SKIP (0.001s) [300.286346] Starting dynamic subtest: ccs0 [300.287945] Dynamic subtest ccs0: SKIP (0.010s) [300.289979] Subtest busy-idle: SKIP (0.019s) [300.341827] [076/133] (728s left) kms_psr (psr2-primary-page-flip) [300.523393] Subtest psr2-primary-page-flip: SKIP (0.000s) [300.577729] [077/133] (728s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [300.786450] Starting subtest: cursorA-vs-flipB-atomic [300.788197] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [300.954535] [078/133] (728s left) kms_prop_blob (blob-prop-lifetime) [301.029675] Starting subtest: blob-prop-lifetime [301.045467] Subtest blob-prop-lifetime: SUCCESS (0.016s) [301.191776] [079/133] (727s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [301.375864] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [301.376682] Starting dynamic subtest: pipe-A [303.316088] Dynamic subtest pipe-A: SUCCESS (1.940s) [303.340543] Starting dynamic subtest: pipe-B [305.429032] Dynamic subtest pipe-B: SUCCESS (2.111s) [305.446629] Starting dynamic subtest: pipe-C [305.726455] Dynamic subtest pipe-C: SUCCESS (0.296s) [305.757080] Starting dynamic subtest: pipe-D [306.039044] Dynamic subtest pipe-D: SUCCESS (0.310s) [306.040078] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.664s) [306.386293] [080/133] (722s left) kms_pipe_crc_basic (hang-read-crc) [306.572476] Starting subtest: hang-read-crc [306.573371] Starting dynamic subtest: pipe-A-DP-3 [308.106514] Dynamic subtest pipe-A-DP-3: SUCCESS (1.533s) [308.127248] Starting dynamic subtest: pipe-B-DP-3 [309.495525] Dynamic subtest pipe-B-DP-3: SUCCESS (1.385s) [309.512442] Starting dynamic subtest: pipe-C-DP-3 [310.804431] Dynamic subtest pipe-C-DP-3: SUCCESS (1.306s) [310.826659] Starting dynamic subtest: pipe-D-DP-3 [312.149198] Dynamic subtest pipe-D-DP-3: SUCCESS (1.341s) [312.150214] Subtest hang-read-crc: SUCCESS (5.577s) [312.473954] [081/133] (716s left) kms_selftest (drm_format) [312.534433] Starting subtest: drm_format [312.545078] Starting dynamic subtest: drm_test_format_block_width_invalid [312.678609] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.123s) [312.723283] Starting dynamic subtest: drm_test_format_block_width_one_plane [312.755034] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.082s) [312.772508] Starting dynamic subtest: drm_test_format_block_width_two_plane [312.841016] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.083s) [312.885670] Starting dynamic subtest: drm_test_format_block_width_three_plane [312.937379] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.092s) [312.952370] Starting dynamic subtest: drm_test_format_block_width_tiled [313.020633] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.079s) [313.068758] Starting dynamic subtest: drm_test_format_block_height_invalid [313.112563] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.088s) [313.144046] Starting dynamic subtest: drm_test_format_block_height_one_plane [313.176324] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.062s) [313.199352] Starting dynamic subtest: drm_test_format_block_height_two_plane [313.243528] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.064s) [313.267111] Starting dynamic subtest: drm_test_format_block_height_three_plane [313.342848] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.096s) [313.384835] Starting dynamic subtest: drm_test_format_block_height_tiled [313.435227] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.088s) [313.480904] Starting dynamic subtest: drm_test_format_min_pitch_invalid [313.525003] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.087s) [313.560633] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp [313.592650] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.065s) [313.610891] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp [313.681301] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.085s) [313.727749] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp [313.776015] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.091s) [313.818470] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp [313.865227] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.086s) [313.904043] Starting dynamic subtest: drm_test_format_min_pitch_two_plane [313.972153] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.104s) [313.987764] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp [314.063955] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.087s) [314.080844] Starting dynamic subtest: drm_test_format_min_pitch_tiled [314.158025] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.088s) [314.159708] Subtest drm_format: SUCCESS (1.624s) [314.406966] [082/133] (714s left) gem_close_race (multigpu-basic-process) [314.529718] Starting subtest: multigpu-basic-process [314.532018] Subtest multigpu-basic-process: SKIP (0.000s) [314.806710] [083/133] (714s left) gem_set_tiling_vs_gtt [314.952578] [084/133] (714s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [315.136820] Starting subtest: planes-downscale-factor-0-5-unity-scaling [315.137614] Starting dynamic subtest: pipe-A [315.220856] Dynamic subtest pipe-A: SUCCESS (0.083s) [315.239617] Starting dynamic subtest: pipe-B [315.435098] Dynamic subtest pipe-B: SUCCESS (0.213s) [315.453263] Starting dynamic subtest: pipe-C [315.631016] Dynamic subtest pipe-C: SUCCESS (0.194s) [315.653891] Starting dynamic subtest: pipe-D [315.860530] Dynamic subtest pipe-D: SUCCESS (0.228s) [315.861449] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.724s) [316.207479] [085/133] (713s left) kms_addfb_basic (basic-y-tiled-legacy) [316.283996] Starting subtest: basic-y-tiled-legacy [316.285651] Subtest basic-y-tiled-legacy: SKIP (0.000s) [316.564712] [086/133] (713s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [316.762931] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [318.091430] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.328s) [318.358822] [087/133] (711s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [318.443605] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [318.445710] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [318.708615] [088/133] (711s left) gem_caching (writes) [318.794483] Starting subtest: writes [322.981075] Subtest writes: SUCCESS (4.186s) [323.185305] [089/133] (706s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [323.262703] Starting subtest: etime-multi-wait-for-submit-unsubmitted [323.365370] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s) [323.520703] [090/133] (706s left) kms_flip (wf_vblank-ts-check) [323.705062] Starting subtest: wf_vblank-ts-check [323.709736] Starting dynamic subtest: A-DP3 [331.841826] Dynamic subtest A-DP3: SUCCESS (8.131s) [331.858986] Starting dynamic subtest: B-DP3 [339.895580] Dynamic subtest B-DP3: SUCCESS (8.051s) [339.910430] Starting dynamic subtest: C-DP3 [347.949432] Dynamic subtest C-DP3: SUCCESS (8.052s) [347.964141] Starting dynamic subtest: D-DP3 [356.008370] Dynamic subtest D-DP3: SUCCESS (8.057s) [356.010713] Subtest wf_vblank-ts-check: SUCCESS (32.303s) [356.358828] [091/133] (673s left) gem_lmem_evict (dontneed-evict-race) [359.250415] Starting subtest: dontneed-evict-race [361.351092] Subtest dontneed-evict-race: SUCCESS (2.101s) [363.218658] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [363.219612] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true [363.221515] [092/133] (666s left) gem_mmap_gtt (medium-copy-odd) [364.836637] Subtest medium-copy-odd: SKIP (0.000s) [364.908470] [FACT gem_mmap_gtt (medium-copy-odd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [364.910973] [FACT gem_mmap_gtt (medium-copy-odd)] new: kernel.kmod_is_loaded.i915: true [364.913646] [093/133] (665s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [365.106496] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [365.111420] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [365.244046] [094/133] (664s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [365.430615] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [365.431497] Starting dynamic subtest: pipe-A-DP-3 [365.452918] Dynamic subtest pipe-A-DP-3: SKIP (0.002s) [365.463717] Starting dynamic subtest: pipe-B-DP-3 [365.485124] Dynamic subtest pipe-B-DP-3: SKIP (0.002s) [365.495638] Starting dynamic subtest: pipe-C-DP-3 [365.520894] Dynamic subtest pipe-C-DP-3: SKIP (0.002s) [365.531849] Starting dynamic subtest: pipe-D-DP-3 [365.553012] Dynamic subtest pipe-D-DP-3: SKIP (0.002s) [365.555273] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.015s) [365.927331] [095/133] (664s left) gem_exec_suspend (basic-s0) [366.018980] Starting subtest: basic-S0 [366.019864] Starting dynamic subtest: smem [387.584989] Dynamic subtest smem: SUCCESS (7.128s) [387.597556] Starting dynamic subtest: lmem0 [408.593990] Dynamic subtest lmem0: SUCCESS (7.173s) [408.594817] Subtest basic-S0: SUCCESS (14.303s) [408.898823] [096/133] (621s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [409.088535] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [410.339080] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.282s) [410.501757] [097/133] (619s left) gem_mmap_offset (bad-extensions) [410.576672] Starting subtest: bad-extensions [410.577547] Subtest bad-extensions: SUCCESS (0.000s) [410.778742] [098/133] (619s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [410.966234] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [410.969376] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s) [411.083218] [099/133] (619s left) gem_mmap_gtt (cpuset-big-copy-odd) [411.161456] Subtest cpuset-big-copy-odd: SKIP (0.000s) [411.227110] [100/133] (619s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [411.419678] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [411.421268] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [411.608193] [101/133] (619s left) kms_psr (fbc-psr2-sprite-render) [411.793764] Subtest fbc-psr2-sprite-render: SKIP (0.000s) [411.848838] [102/133] (618s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [412.044153] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [412.045671] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [412.246698] [103/133] (618s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [412.429575] Starting subtest: crc-primary-basic-y-tiled-ccs [412.430415] Starting dynamic subtest: pipe-A-DP-3 [412.438696] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [412.450003] Starting dynamic subtest: pipe-B-DP-3 [412.458151] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [412.469328] Starting dynamic subtest: pipe-C-DP-3 [412.477538] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [412.488784] Starting dynamic subtest: pipe-D-DP-3 [412.497892] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [412.499749] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.009s) [412.847999] [104/133] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [413.033227] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [413.034827] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [413.237856] [105/133] (617s left) api_intel_bb (add-remove-objects) [413.319634] Starting subtest: add-remove-objects [413.353194] Subtest add-remove-objects: SUCCESS (0.034s) [413.501977] [106/133] (617s left) sysfs_heartbeat_interval (nopreempt) [413.584581] Starting subtest: nopreempt [413.585433] Starting dynamic subtest: vecs0 [417.923852] Dynamic subtest vecs0: SUCCESS (4.391s) [417.936742] Starting dynamic subtest: ccs0 [422.217554] Dynamic subtest ccs0: SUCCESS (4.323s) [422.230874] Starting dynamic subtest: vcs0 [426.479568] Dynamic subtest vcs0: SUCCESS (4.278s) [426.494109] Starting dynamic subtest: bcs0 [430.658361] Dynamic subtest bcs0: SUCCESS (4.188s) [430.670596] Starting dynamic subtest: vecs1 [434.915556] Dynamic subtest vecs1: SUCCESS (4.263s) [434.927739] Starting dynamic subtest: rcs0 [439.241515] Dynamic subtest rcs0: SUCCESS (4.330s) [439.253907] Starting dynamic subtest: vcs1 [443.427781] Dynamic subtest vcs1: SUCCESS (4.184s) [443.428706] Subtest nopreempt: SUCCESS (29.967s) [443.621395] [107/133] (587s left) kms_getfb (getfb2-into-addfb2) [443.812694] Starting subtest: getfb2-into-addfb2 [443.813553] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [444.028120] [108/133] (587s left) gem_close (basic) [444.123639] Starting subtest: basic [444.124607] Subtest basic: SUCCESS (0.000s) [444.327032] [109/133] (586s left) gem_exec_schedule (preemptive-hang) [444.527241] Starting subtest: preemptive-hang [444.528189] Starting dynamic subtest: rcs0 [453.596255] Dynamic subtest rcs0: SUCCESS (9.064s) [453.610438] Starting dynamic subtest: bcs0 [462.552779] Dynamic subtest bcs0: SUCCESS (8.953s) [462.565491] Starting dynamic subtest: vcs0 [471.601723] Dynamic subtest vcs0: SUCCESS (9.032s) [471.623222] Starting dynamic subtest: vcs1 [480.598759] Dynamic subtest vcs1: SUCCESS (9.013s) [480.611085] Starting dynamic subtest: vecs0 [489.559710] Dynamic subtest vecs0: SUCCESS (8.963s) [489.571968] Starting dynamic subtest: vecs1 [498.595825] Dynamic subtest vecs1: SUCCESS (9.037s) [498.608069] Starting dynamic subtest: ccs0 [507.546752] Dynamic subtest ccs0: SUCCESS (8.951s) [507.547590] Subtest preemptive-hang: SUCCESS (63.021s) [507.890514] [110/133] (523s left) i915_drm_fdinfo (virtual-busy-idle) [507.961684] Starting subtest: virtual-busy-idle [507.963464] Subtest virtual-busy-idle: SKIP (0.000s) [508.085216] [111/133] (523s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [508.278457] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [508.280212] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [508.456785] [112/133] (523s left) gem_linear_blits (interruptible) [508.725665] Starting subtest: interruptible [515.714887] Subtest interruptible: SUCCESS (6.987s) [516.004556] [113/133] (515s left) gem_ctx_persistence (engines-mixed) [516.129964] Starting subtest: engines-mixed [516.130987] Starting dynamic subtest: rcs0 [516.237657] Dynamic subtest rcs0: SUCCESS (0.109s) [516.257707] Starting dynamic subtest: bcs0 [516.284774] Dynamic subtest bcs0: SUCCESS (0.046s) [516.311927] Starting dynamic subtest: vcs0 [516.335819] Dynamic subtest vcs0: SUCCESS (0.049s) [516.357368] Starting dynamic subtest: vcs1 [516.384597] Dynamic subtest vcs1: SUCCESS (0.047s) [516.411552] Starting dynamic subtest: vecs0 [516.461962] Dynamic subtest vecs0: SUCCESS (0.075s) [516.500138] Starting dynamic subtest: vecs1 [516.539935] Dynamic subtest vecs1: SUCCESS (0.075s) [516.571994] Starting dynamic subtest: ccs0 [516.610842] Dynamic subtest ccs0: SUCCESS (0.069s) [516.612003] Subtest engines-mixed: SUCCESS (0.483s) [516.817821] [114/133] (514s left) perf_pmu (init-wait) [516.887647] Starting subtest: init-wait [516.888555] Starting dynamic subtest: rcs0 [516.891750] Dynamic subtest rcs0: SUCCESS (0.003s) [516.904579] Starting dynamic subtest: bcs0 [516.905417] Dynamic subtest bcs0: SUCCESS (0.001s) [516.917816] Starting dynamic subtest: vcs0 [516.918695] Dynamic subtest vcs0: SUCCESS (0.001s) [516.931555] Starting dynamic subtest: vcs1 [516.932843] Dynamic subtest vcs1: SUCCESS (0.001s) [516.945322] Starting dynamic subtest: vecs0 [516.946517] Dynamic subtest vecs0: SUCCESS (0.001s) [516.958959] Starting dynamic subtest: vecs1 [516.960037] Dynamic subtest vecs1: SUCCESS (0.001s) [516.972473] Starting dynamic subtest: ccs0 [516.973690] Dynamic subtest ccs0: SUCCESS (0.001s) [516.974703] Subtest init-wait: SUCCESS (0.014s) [517.051921] [115/133] (514s left) gem_exec_reloc (basic-gtt-cpu-active) [517.134478] Subtest basic-gtt-cpu-active: SKIP (0.000s) [517.234209] [116/133] (514s left) kms_pm_lpsp (screens-disabled) [518.446467] Starting subtest: screens-disabled [518.448279] Subtest screens-disabled: SKIP (0.000s) [518.572232] [117/133] (513s left) kms_flip (flip-vs-expired-vblank-interruptible) [518.769183] Starting subtest: flip-vs-expired-vblank-interruptible [518.774008] Starting dynamic subtest: A-DP3 [526.629047] Dynamic subtest A-DP3: SUCCESS (7.853s) [526.650839] Starting dynamic subtest: B-DP3 [534.372455] Dynamic subtest B-DP3: SUCCESS (7.740s) [534.416651] Starting dynamic subtest: C-DP3 [542.131839] Dynamic subtest C-DP3: SUCCESS (7.754s) [542.148313] Starting dynamic subtest: D-DP3 [549.888782] Dynamic subtest D-DP3: SUCCESS (7.755s) [549.897241] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (31.125s) [550.269451] [118/133] (481s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [550.459502] Starting subtest: psr-1p-primscrn-cur-indfb-move [550.461224] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [550.593687] [119/133] (481s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [550.784633] Starting subtest: plane-all-modeset-transition-internal-panels [550.786486] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s) [550.935532] [120/133] (481s left) gem_userptr_blits (stress-mm) [551.027266] Starting subtest: stress-mm [556.396064] Subtest stress-mm: SUCCESS (5.369s) [556.596732] [121/133] (475s left) syncobj_eventfd (invalid-bad-flags) [556.678656] Starting subtest: invalid-bad-flags [556.679586] Subtest invalid-bad-flags: SUCCESS (0.000s) [556.822918] [122/133] (475s left) kms_addfb_basic (framebuffer-vs-set-tiling) [556.900063] Starting subtest: framebuffer-vs-set-tiling [556.901732] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [557.170176] [123/133] (475s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [557.361470] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [557.363198] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [557.550621] [124/133] (474s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [557.627657] Starting subtest: multi-wait-for-submit-available-submitted-signaled [557.628549] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [557.816432] [125/133] (474s left) kms_flip (2x-modeset-vs-vblank-race) [557.998287] Starting subtest: 2x-modeset-vs-vblank-race [558.013799] Subtest 2x-modeset-vs-vblank-race: SKIP (0.015s) [558.167501] [126/133] (474s left) i915_query (query-regions-garbage-items) [558.245576] Starting subtest: query-regions-garbage-items [558.246462] Subtest query-regions-garbage-items: SUCCESS (0.000s) [558.450247] [127/133] (474s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [558.527542] Subtest flip-primary-invalidate-overlay: SKIP (0.000s) [558.598878] [128/133] (474s left) gem_exec_balancer (full-late) [558.686904] Starting subtest: full-late [560.740744] Subtest full-late: SUCCESS (2.054s) [561.156013] [129/133] (471s left) gem_exec_reloc (basic-write-wc) [561.243725] Subtest basic-write-wc: SKIP (0.000s) [561.335564] [130/133] (471s left) kms_force_connector_basic (force-load-detect) [561.443282] Starting subtest: force-load-detect [561.444872] Subtest force-load-detect: SKIP (0.000s) [561.698351] [131/133] (471s left) kms_chamelium_hpd (hdmi-hpd-fast) [561.963555] Subtest hdmi-hpd-fast: SKIP (0.000s) [562.121417] [132/133] (470s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [562.309605] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [562.310495] Starting dynamic subtest: pipe-A-valid-mode [564.167912] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.855s) [564.169282] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (1.859s) [564.523833] [133/133] (468s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [564.724428] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [564.726170] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [564.919413] Closing watchdogs results: parsing output: 0/ for test: kms_content_protection results: parsing output: 1/ for test: core_getversion results: parsing output: 2/ for test: kms_atomic_interruptible results: parsing output: 3/ for test: kms_plane results: parsing output: 4/ for test: kms_atomic_transition results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_psr results: parsing output: 7/ for test: perf results: parsing output: 8/ for test: gem_eio results: parsing output: 9/ for test: kms_color results: parsing output: 10/ for test: gem_softpin results: parsing output: 11/ for test: kms_psr2_sf results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: kms_psr results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_psr2_sf results: parsing output: 16/ for test: gem_ccs results: parsing output: 17/ for test: perf results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_pxp results: parsing output: 20/ for test: gem_eio results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_exec_schedule results: parsing output: 23/ for test: core_getstats results: parsing output: 24/ for test: kms_ccs results: parsing output: 25/ for test: kms_ccs results: parsing output: 26/ for test: sw_sync results: parsing output: 27/ for test: i915_pm_rps results: parsing output: 28/ for test: kms_cursor_legacy results: parsing output: 29/ for test: kms_cursor_crc results: parsing output: 30/ for test: kms_dp_link_training results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: gem_exec_parallel results: parsing output: 33/ for test: gem_eio results: parsing output: 34/ for test: prime_mmap results: parsing output: 35/ for test: kms_dsc results: parsing output: 36/ for test: prime_busy results: parsing output: 37/ for test: kms_vblank results: parsing output: 38/ for test: kms_pm_rpm results: parsing output: 39/ for test: kms_cursor_legacy results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: perf results: parsing output: 43/ for test: gem_wait results: parsing output: 44/ for test: gen9_exec_parse results: parsing output: 45/ for test: kms_cursor_edge_walk results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: prime_mmap results: parsing output: 48/ for test: kms_addfb_basic results: parsing output: 49/ for test: kms_chamelium_audio results: parsing output: 50/ for test: kms_chamelium_edid results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_flip_scaled_crc results: parsing output: 53/ for test: perf results: parsing output: 54/ for test: kms_joiner results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: kms_legacy_colorkey results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: gem_render_copy results: parsing output: 60/ for test: gem_exec_reloc results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: syncobj_wait results: parsing output: 63/ for test: kms_async_flips results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: syncobj_timeline results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: gem_ctx_persistence results: parsing output: 69/ for test: gem_exec_big results: parsing output: 70/ for test: gem_exec_fence results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: i915_drm_fdinfo results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: kms_cursor_legacy results: parsing output: 77/ for test: kms_prop_blob results: parsing output: 78/ for test: kms_plane_scaling results: parsing output: 79/ for test: kms_pipe_crc_basic results: parsing output: 80/ for test: kms_selftest results: parsing output: 81/ for test: gem_close_race results: parsing output: 82/ for test: gem_set_tiling_vs_gtt results: parsing output: 83/ for test: kms_plane_scaling results: parsing output: 84/ for test: kms_addfb_basic results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: gem_render_copy results: parsing output: 87/ for test: gem_caching results: parsing output: 88/ for test: syncobj_timeline results: parsing output: 89/ for test: kms_flip results: parsing output: 90/ for test: gem_lmem_evict results: parsing output: 91/ for test: gem_mmap_gtt results: parsing output: 92/ for test: kms_plane results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: gem_exec_suspend results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: gem_mmap_offset results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: gem_mmap_gtt results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: kms_psr results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_ccs results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: api_intel_bb results: parsing output: 105/ for test: sysfs_heartbeat_interval results: parsing output: 106/ for test: kms_getfb results: parsing output: 107/ for test: gem_close results: parsing output: 108/ for test: gem_exec_schedule results: parsing output: 109/ for test: i915_drm_fdinfo results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: gem_linear_blits results: parsing output: 112/ for test: gem_ctx_persistence results: parsing output: 113/ for test: perf_pmu results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_pm_lpsp results: parsing output: 116/ for test: kms_flip results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_atomic_transition results: parsing output: 119/ for test: gem_userptr_blits results: parsing output: 120/ for test: syncobj_eventfd results: parsing output: 121/ for test: kms_addfb_basic results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: syncobj_timeline results: parsing output: 124/ for test: kms_flip results: parsing output: 125/ for test: i915_query results: parsing output: 126/ for test: kms_psr_stress_test results: parsing output: 127/ for test: gem_exec_balancer results: parsing output: 128/ for test: gem_exec_reloc results: parsing output: 129/ for test: kms_force_connector_basic results: parsing output: 130/ for test: kms_chamelium_hpd results: parsing output: 131/ for test: kms_flip_scaled_crc results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.