[62.235508] Initializing watchdogs [62.235573] /dev/watchdog0 [62.254869] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [62.265670] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [62.269603] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.271821] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [62.522531] Starting subtest: dp-mst-lic-type-0-hdcp14 [62.524263] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [62.722607] [002/133] (960s left) core_getversion (all-cards) [62.777939] Starting subtest: all-cards [62.806047] Subtest all-cards: SUCCESS (0.029s) [62.852770] [003/133] (960s left) kms_atomic_interruptible (legacy-dpms) [63.031852] Starting subtest: legacy-dpms [63.032735] Starting dynamic subtest: pipe-A-DP-3 [69.333868] Dynamic subtest pipe-A-DP-3: SUCCESS (6.301s) [69.334827] Subtest legacy-dpms: SUCCESS (6.302s) [69.573603] [004/133] (953s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping) [69.759384] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping [69.764343] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [69.874477] [005/133] (953s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [70.055448] Starting subtest: plane-primary-toggle-with-vblank-wait [70.057276] Starting dynamic subtest: pipe-A-DP-3 [70.282218] Dynamic subtest pipe-A-DP-3: SUCCESS (0.225s) [70.417035] Starting dynamic subtest: pipe-B-DP-3 [70.687328] Dynamic subtest pipe-B-DP-3: SUCCESS (0.279s) [70.794216] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.738s) [71.053954] [006/133] (952s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [71.241381] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [71.242987] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [71.433699] [007/133] (951s left) kms_psr (fbc-psr2-primary-mmap-cpu) [71.610478] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s) [71.663364] [008/133] (951s left) perf (invalid-oa-exponent) [72.093792] Starting subtest: invalid-oa-exponent [72.116960] Subtest invalid-oa-exponent: SUCCESS (0.023s) [72.165149] [009/133] (951s left) gem_eio (create-ext) [72.460960] Starting subtest: create-ext [72.993582] Subtest create-ext: SUCCESS (0.533s) [73.256386] [010/133] (950s left) kms_color (invalid-degamma-lut-sizes) [73.433916] Starting subtest: invalid-degamma-lut-sizes [73.434807] Starting dynamic subtest: pipe-A [73.519446] Dynamic subtest pipe-A: SUCCESS (0.085s) [73.529749] Starting dynamic subtest: pipe-B [73.530663] Dynamic subtest pipe-B: SUCCESS (0.001s) [73.540730] Starting dynamic subtest: pipe-C [73.541598] Dynamic subtest pipe-C: SUCCESS (0.001s) [73.550162] Starting dynamic subtest: pipe-D [73.551010] Dynamic subtest pipe-D: SUCCESS (0.001s) [73.551932] Subtest invalid-degamma-lut-sizes: SUCCESS (0.088s) [73.758196] [011/133] (949s left) gem_softpin (allocator-basic) [73.837944] Starting subtest: allocator-basic [74.060562] Subtest allocator-basic: SUCCESS (0.223s) [74.307638] [012/133] (949s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [74.490366] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [74.548368] [013/133] (948s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [74.737760] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [74.739403] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [74.923661] [014/133] (948s left) kms_psr (pr-primary-render) [75.098317] Subtest pr-primary-render: SKIP (0.000s) [75.148487] [015/133] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [75.327422] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [75.329056] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [75.471264] [016/133] (948s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [75.659786] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [75.714839] [017/133] (948s left) gem_ccs (ctrl-surf-copy) [75.790956] Starting subtest: ctrl-surf-copy [75.791843] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0 [75.847388] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.056s) [75.855788] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0 [76.071468] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.224s) [76.080172] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0 [76.100401] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.029s) [76.108795] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0 [76.320465] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.220s) [76.328899] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0 [76.349193] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s) [76.357493] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0 [76.568789] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.219s) [76.577345] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0 [76.597662] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.029s) [76.606174] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0 [76.816847] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.219s) [76.817793] Subtest ctrl-surf-copy: SUCCESS (1.026s) [77.041544] [018/133] (946s left) perf (invalid-oa-metric-set-id) [77.308877] Starting subtest: invalid-oa-metric-set-id [77.325426] Subtest invalid-oa-metric-set-id: SUCCESS (0.017s) [77.384119] [019/133] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [77.571253] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [77.572972] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [77.758443] [020/133] (946s left) gem_pxp (create-regular-buffer) [80.350231] Starting subtest: create-regular-buffer [80.352405] Subtest create-regular-buffer: SKIP (0.000s) [80.487325] [021/133] (943s left) gem_eio (in-flight-contexts-10ms) [80.783334] Starting subtest: in-flight-contexts-10ms [94.966513] Subtest in-flight-contexts-10ms: SUCCESS (14.181s) [95.268119] [022/133] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [95.452330] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [95.454015] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [95.643376] [023/133] (928s left) gem_exec_schedule (u-fairslice-all) [95.732790] Starting subtest: u-fairslice-all [97.858533] Subtest u-fairslice-all: SUCCESS (2.126s) [98.292843] [024/133] (925s left) core_getstats (basic) [98.361041] Starting subtest: basic [98.362074] Subtest basic: SUCCESS (0.000s) [98.552473] [025/133] (925s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [98.735743] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [98.736577] Starting dynamic subtest: pipe-A-DP-3 [98.745017] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [98.753883] Starting dynamic subtest: pipe-B-DP-3 [98.762031] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [98.770768] Starting dynamic subtest: pipe-C-DP-3 [98.778733] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [98.787475] Starting dynamic subtest: pipe-D-DP-3 [98.797642] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [98.799471] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.006s) [99.208251] [026/133] (925s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [99.385925] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [99.386842] Starting dynamic subtest: pipe-A-DP-3 [99.395164] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [99.403902] Starting dynamic subtest: pipe-B-DP-3 [99.412024] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [99.420686] Starting dynamic subtest: pipe-C-DP-3 [99.428959] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [99.437350] Starting dynamic subtest: pipe-D-DP-3 [99.447129] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [99.448906] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s) [99.895676] [027/133] (924s left) sw_sync (alloc_fence) [99.937971] Starting subtest: alloc_fence [99.939589] Subtest alloc_fence: SUCCESS (0.000s) [100.087573] [028/133] (924s left) i915_pm_rps (basic-api) [100.163799] Starting subtest: basic-api [100.165706] Subtest basic-api: SKIP (0.000s) [100.318332] [029/133] (924s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [100.497914] Starting subtest: cursorB-vs-flipA-toggle [100.500604] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s) [100.637755] [030/133] (924s left) kms_cursor_crc (cursor-rapid-movement-128x42) [101.017898] Starting subtest: cursor-rapid-movement-128x42 [101.021753] Starting dynamic subtest: pipe-A-DP-3 [101.481829] Dynamic subtest pipe-A-DP-3: SUCCESS (0.460s) [101.515057] Starting dynamic subtest: pipe-D-DP-3 [101.880749] Dynamic subtest pipe-D-DP-3: SUCCESS (0.373s) [101.881661] Subtest cursor-rapid-movement-128x42: SUCCESS (0.863s) [102.356639] [031/133] (922s left) kms_dp_link_training (non-uhbr-sst) [102.533916] Starting subtest: non-uhbr-sst [104.702490] Subtest non-uhbr-sst: SUCCESS (2.166s) [104.904262] [032/133] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [105.085406] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [105.087057] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [105.287402] [033/133] (919s left) gem_exec_parallel (engines) [105.377563] Starting subtest: engines [105.378476] Starting dynamic subtest: basic [106.929439] Dynamic subtest basic: SUCCESS (1.552s) [106.939190] Starting dynamic subtest: contexts [111.387215] Dynamic subtest contexts: SUCCESS (4.457s) [111.396643] Starting dynamic subtest: fds [116.001601] Dynamic subtest fds: SUCCESS (4.614s) [116.012072] Starting dynamic subtest: userptr [117.502581] Dynamic subtest userptr: SUCCESS (1.501s) [117.503827] Subtest engines: SUCCESS (12.125s) [117.796570] [034/133] (907s left) gem_eio (in-flight-immediate) [118.082863] Starting subtest: in-flight-immediate [123.373443] Subtest in-flight-immediate: SUCCESS (5.291s) [123.656078] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true [123.658127] [035/133] (901s left) prime_mmap (test_forked) [123.734356] Starting subtest: test_forked [123.735260] Starting dynamic subtest: test_forked-smem [123.788194] Dynamic subtest test_forked-smem: SUCCESS (0.054s) [123.798537] Starting dynamic subtest: test_forked-lmem0 [123.985219] Dynamic subtest test_forked-lmem0: SUCCESS (0.196s) [123.986266] Subtest test_forked: SUCCESS (0.251s) [124.117654] [036/133] (901s left) kms_dsc (dsc-with-formats) [124.299467] Starting subtest: dsc-with-formats [124.314947] Subtest dsc-with-formats: SKIP (0.002s) [124.463111] [037/133] (900s left) prime_busy (hang) [124.547125] Starting subtest: hang [124.549082] Starting dynamic subtest: rcs0 [150.507439] Dynamic subtest rcs0: SUCCESS (25.958s) [150.517197] Starting dynamic subtest: bcs0 [157.673293] Dynamic subtest bcs0: SUCCESS (7.165s) [157.682796] Starting dynamic subtest: vcs0 [164.640953] Dynamic subtest vcs0: SUCCESS (6.968s) [164.650647] Starting dynamic subtest: vcs1 [171.619054] Dynamic subtest vcs1: SUCCESS (6.978s) [171.629008] Starting dynamic subtest: vecs0 [178.664158] Dynamic subtest vecs0: SUCCESS (7.045s) [178.673854] Starting dynamic subtest: vecs1 [185.636173] Dynamic subtest vecs1: SUCCESS (6.971s) [185.645735] Starting dynamic subtest: ccs0 [199.472397] Dynamic subtest ccs0: SUCCESS (13.836s) [199.473315] Subtest hang: SUCCESS (74.923s) [199.632864] [038/133] (825s left) kms_vblank (wait-idle) [199.819665] Starting subtest: wait-idle [199.821489] Starting dynamic subtest: pipe-A-DP-3 [202.128523] Dynamic subtest pipe-A-DP-3: SUCCESS (2.307s) [202.144200] Starting dynamic subtest: pipe-D-DP-3 [204.373527] Dynamic subtest pipe-D-DP-3: SUCCESS (2.240s) [204.374479] Subtest wait-idle: SUCCESS (4.554s) [204.664770] [039/133] (820s left) kms_pm_rpm (package-g7) [207.078047] Starting subtest: package-g7 [207.080355] Subtest package-g7: SKIP (0.000s) [207.525741] [040/133] (817s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [207.717891] Starting subtest: flip-vs-cursor-varying-size [219.678377] Subtest flip-vs-cursor-varying-size: SUCCESS (11.960s) [220.002508] [041/133] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [220.190862] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [220.192474] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [220.362313] [042/133] (805s left) syncobj_timeline (single-wait-all-for-submit-signaled) [220.440137] Starting subtest: single-wait-all-for-submit-signaled [220.441136] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [220.632842] [043/133] (805s left) perf (gen12-group-exclusive-stream-ctx-handle) [220.878983] Starting subtest: gen12-group-exclusive-stream-ctx-handle [220.907276] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.028s) [220.967501] [044/133] (804s left) gem_wait (busy) [221.058144] Starting subtest: busy [221.059009] Starting dynamic subtest: all-engines [221.666445] Dynamic subtest all-engines: SUCCESS (0.609s) [221.676597] Starting dynamic subtest: rcs0 [222.205306] Dynamic subtest rcs0: SUCCESS (0.538s) [222.215082] Starting dynamic subtest: bcs0 [222.745530] Dynamic subtest bcs0: SUCCESS (0.539s) [222.759379] Starting dynamic subtest: vcs0 [223.289332] Dynamic subtest vcs0: SUCCESS (0.542s) [223.299089] Starting dynamic subtest: vcs1 [223.828395] Dynamic subtest vcs1: SUCCESS (0.539s) [223.838138] Starting dynamic subtest: vecs0 [224.367382] Dynamic subtest vecs0: SUCCESS (0.539s) [224.377120] Starting dynamic subtest: vecs1 [224.907211] Dynamic subtest vecs1: SUCCESS (0.539s) [224.917123] Starting dynamic subtest: ccs0 [225.446239] Dynamic subtest ccs0: SUCCESS (0.538s) [225.447152] Subtest busy: SUCCESS (4.389s) [225.793509] [045/133] (800s left) gen9_exec_parse (bb-secure) [225.877251] Subtest bb-secure: SKIP (0.000s) [225.979907] [046/133] (799s left) kms_cursor_edge_walk (128x128-right-edge) [226.168186] Starting subtest: 128x128-right-edge [226.169129] Starting dynamic subtest: pipe-A-DP-3 [229.646239] Dynamic subtest pipe-A-DP-3: SUCCESS (3.477s) [229.659608] Starting dynamic subtest: pipe-D-DP-3 [232.941998] Dynamic subtest pipe-D-DP-3: SUCCESS (3.294s) [232.942874] Subtest 128x128-right-edge: SUCCESS (6.775s) [233.257252] [047/133] (792s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [233.446482] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [233.448140] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [233.611202] [048/133] (792s left) prime_mmap (test_forked_cpu_write) [233.687474] Starting subtest: test_forked_cpu_write [233.688391] Starting dynamic subtest: test_forked_cpu_write-smem [233.695909] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s) [233.705600] Starting dynamic subtest: test_forked_cpu_write-lmem0 [233.706457] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.009s) [233.707336] Subtest test_forked_cpu_write: SUCCESS (0.018s) [233.891833] [049/133] (792s left) kms_addfb_basic (small-bo) [234.077525] Starting subtest: small-bo [234.078400] Subtest small-bo: SUCCESS (0.000s) [234.240430] [050/133] (792s left) kms_chamelium_audio (dp-audio) [234.521627] Subtest dp-audio: SKIP (0.000s) [234.675863] [051/133] (791s left) kms_chamelium_edid (hdmi-edid-change-during-suspend) [234.946382] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s) [235.101225] [052/133] (791s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [235.295627] Starting subtest: psr-shrfb-scaledprimary [235.297264] Subtest psr-shrfb-scaledprimary: SKIP (0.000s) [235.492327] [053/133] (791s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [235.677577] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [235.679286] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [235.820389] [054/133] (790s left) perf (i915-ref-count) [235.930375] Starting subtest: i915-ref-count [236.028884] Subtest i915-ref-count: SUCCESS (0.098s) [236.155149] [055/133] (790s left) kms_joiner (invalid-modeset-force-big-joiner) [236.340321] Starting subtest: invalid-modeset-force-big-joiner [236.341141] Starting dynamic subtest: big_joiner_on_last_pipe [236.577026] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.238s) [236.577857] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.239s) [236.887996] [056/133] (789s left) kms_cursor_crc (cursor-alpha-opaque) [237.081259] Starting subtest: cursor-alpha-opaque [237.082171] Starting dynamic subtest: pipe-A-DP-3 [237.715240] Dynamic subtest pipe-A-DP-3: SUCCESS (0.632s) [237.740171] Starting dynamic subtest: pipe-D-DP-3 [238.248251] Dynamic subtest pipe-D-DP-3: SUCCESS (0.529s) [238.249508] Subtest cursor-alpha-opaque: SUCCESS (1.168s) [238.928434] [057/133] (787s left) kms_legacy_colorkey (basic) [239.121370] Starting subtest: basic [239.122282] Starting dynamic subtest: pipe-A [239.177748] Dynamic subtest pipe-A: SUCCESS (0.056s) [239.191423] Starting dynamic subtest: pipe-B [239.192470] Dynamic subtest pipe-B: SUCCESS (0.000s) [239.206787] Starting dynamic subtest: pipe-C [239.208026] Dynamic subtest pipe-C: SUCCESS (0.000s) [239.222171] Starting dynamic subtest: pipe-D [239.223083] Dynamic subtest pipe-D: SUCCESS (0.000s) [239.224315] Subtest basic: SUCCESS (0.061s) [239.362123] [058/133] (787s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip) [239.558061] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip [239.559864] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [239.745709] [059/133] (787s left) kms_addfb_basic (bad-pitch-32) [239.818322] Starting subtest: bad-pitch-32 [239.819220] Subtest bad-pitch-32: SUCCESS (0.000s) [240.124266] [060/133] (786s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [240.208467] Starting subtest: x-tiled-to-vebox-y-tiled [240.210575] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [240.478437] [061/133] (786s left) gem_exec_reloc (basic-range) [240.573563] Subtest basic-range: SKIP (0.000s) [240.666977] [062/133] (786s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [240.860572] Starting subtest: yf-tiled-64bpp-rotate-0 [240.862265] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [241.058528] [063/133] (786s left) syncobj_wait (wait-all-for-submit-snapshot) [241.134290] Starting subtest: wait-all-for-submit-snapshot [241.217528] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [241.395289] [064/133] (785s left) kms_async_flips (invalid-async-flip) [241.580125] Starting subtest: invalid-async-flip [241.812464] Starting dynamic subtest: pipe-A-DP-3 [242.189959] Dynamic subtest pipe-A-DP-3: SUCCESS (0.377s) [242.393796] Starting dynamic subtest: pipe-B-DP-3 [242.553524] Dynamic subtest pipe-B-DP-3: SUCCESS (0.170s) [242.758190] Starting dynamic subtest: pipe-C-DP-3 [242.890819] Dynamic subtest pipe-C-DP-3: SUCCESS (0.143s) [243.087779] Starting dynamic subtest: pipe-D-DP-3 [243.245637] Dynamic subtest pipe-D-DP-3: SUCCESS (0.168s) [243.246660] Subtest invalid-async-flip: SUCCESS (1.667s) [243.768251] [065/133] (783s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [243.957120] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [243.960551] Starting dynamic subtest: A-DP3 [244.941865] Dynamic subtest A-DP3: SUCCESS (0.980s) [244.964589] Starting dynamic subtest: B-DP3 [245.690433] Dynamic subtest B-DP3: SUCCESS (0.745s) [245.700732] Starting dynamic subtest: C-DP3 [246.436569] Dynamic subtest C-DP3: SUCCESS (0.745s) [246.446678] Starting dynamic subtest: D-DP3 [247.179591] Dynamic subtest D-DP3: SUCCESS (0.742s) [247.180425] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.224s) [247.510551] [066/133] (780s left) kms_frontbuffer_tracking (fbc-suspend) [247.706953] Starting subtest: fbc-suspend [289.550968] Subtest fbc-suspend: SUCCESS (11.080s) [289.807249] [067/133] (737s left) syncobj_timeline (invalid-transfer-bad-pad) [289.890096] Starting subtest: invalid-transfer-bad-pad [289.891028] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [290.054372] [068/133] (737s left) kms_big_fb (4-tiled-64bpp-rotate-90) [290.248145] Starting subtest: 4-tiled-64bpp-rotate-90 [290.301062] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.052s) [290.497755] [069/133] (737s left) gem_ctx_persistence (saturated-hostile-nopreempt) [290.578765] Starting subtest: saturated-hostile-nopreempt [290.580094] Starting dynamic subtest: rcs0 [290.672204] Dynamic subtest rcs0: SKIP (0.092s) [290.689793] Starting dynamic subtest: bcs0 [290.691829] Dynamic subtest bcs0: SKIP (0.016s) [290.710979] Starting dynamic subtest: vcs0 [290.713406] Dynamic subtest vcs0: SKIP (0.011s) [290.727784] Starting dynamic subtest: vcs1 [290.730116] Dynamic subtest vcs1: SKIP (0.014s) [290.741759] Starting dynamic subtest: vecs0 [290.743882] Dynamic subtest vecs0: SKIP (0.015s) [290.755334] Starting dynamic subtest: vecs1 [290.757443] Dynamic subtest vecs1: SKIP (0.022s) [290.769351] Starting dynamic subtest: ccs0 [290.771209] Dynamic subtest ccs0: SKIP (0.015s) [290.773041] Subtest saturated-hostile-nopreempt: SKIP (0.192s) [290.982979] [070/133] (736s left) gem_exec_big (single) [291.066841] Starting subtest: single [296.525405] Subtest single: SUCCESS (5.458s) [297.243243] [071/133] (730s left) gem_exec_fence (submit67) [297.540208] Starting subtest: submit67 [297.542014] Subtest submit67: SKIP (0.000s) [298.264805] [072/133] (729s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [298.492722] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [298.494371] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [298.615805] [073/133] (729s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [298.805922] Starting subtest: fbc-rgb101010-draw-mmap-wc [298.807705] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s) [298.981892] [074/133] (729s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [299.176769] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [299.178398] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [299.376426] [075/133] (728s left) i915_drm_fdinfo (busy-idle) [299.446334] Starting subtest: busy-idle [299.447440] Starting dynamic subtest: rcs0 [299.461087] Dynamic subtest rcs0: SKIP (0.015s) [299.473997] Starting dynamic subtest: bcs0 [299.476015] Dynamic subtest bcs0: SKIP (0.000s) [299.488508] Starting dynamic subtest: vcs0 [299.490674] Dynamic subtest vcs0: SKIP (0.000s) [299.503254] Starting dynamic subtest: vcs1 [299.505646] Dynamic subtest vcs1: SKIP (0.000s) [299.517889] Starting dynamic subtest: vecs0 [299.520211] Dynamic subtest vecs0: SKIP (0.000s) [299.532293] Starting dynamic subtest: vecs1 [299.541955] Dynamic subtest vecs1: SKIP (0.000s) [299.554009] Starting dynamic subtest: ccs0 [299.556405] Dynamic subtest ccs0: SKIP (0.000s) [299.558403] Subtest busy-idle: SKIP (0.023s) [299.605163] [076/133] (728s left) kms_psr (psr2-primary-page-flip) [299.794179] Subtest psr2-primary-page-flip: SKIP (0.000s) [299.862365] [077/133] (728s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [300.050270] Starting subtest: cursorA-vs-flipB-atomic [300.052064] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [300.221230] [078/133] (728s left) kms_prop_blob (blob-prop-lifetime) [300.301308] Starting subtest: blob-prop-lifetime [300.316135] Subtest blob-prop-lifetime: SUCCESS (0.016s) [300.515462] [079/133] (727s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [300.697212] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [300.697969] Starting dynamic subtest: pipe-A [302.700374] Dynamic subtest pipe-A: SUCCESS (2.003s) [302.725043] Starting dynamic subtest: pipe-B [304.647331] Dynamic subtest pipe-B: SUCCESS (1.945s) [304.660211] Starting dynamic subtest: pipe-C [304.943789] Dynamic subtest pipe-C: SUCCESS (0.296s) [304.966523] Starting dynamic subtest: pipe-D [305.257893] Dynamic subtest pipe-D: SUCCESS (0.312s) [305.259157] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.563s) [305.642083] [080/133] (722s left) kms_pipe_crc_basic (hang-read-crc) [305.829253] Starting subtest: hang-read-crc [305.830071] Starting dynamic subtest: pipe-A-DP-3 [307.373179] Dynamic subtest pipe-A-DP-3: SUCCESS (1.543s) [307.390492] Starting dynamic subtest: pipe-B-DP-3 [308.761857] Dynamic subtest pipe-B-DP-3: SUCCESS (1.386s) [308.778262] Starting dynamic subtest: pipe-C-DP-3 [310.087144] Dynamic subtest pipe-C-DP-3: SUCCESS (1.323s) [310.104198] Starting dynamic subtest: pipe-D-DP-3 [311.444300] Dynamic subtest pipe-D-DP-3: SUCCESS (1.355s) [311.445182] Subtest hang-read-crc: SUCCESS (5.616s) [311.739677] [081/133] (716s left) kms_selftest (drm_format) [311.804054] Starting subtest: drm_format [311.815614] Starting dynamic subtest: drm_test_format_block_width_invalid [311.904117] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.088s) [311.941166] Starting dynamic subtest: drm_test_format_block_width_one_plane [311.997651] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.090s) [312.014069] Starting dynamic subtest: drm_test_format_block_width_two_plane [312.092361] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.088s) [312.137478] Starting dynamic subtest: drm_test_format_block_width_three_plane [312.190056] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.093s) [312.231323] Starting dynamic subtest: drm_test_format_block_width_tiled [312.274739] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.082s) [312.298583] Starting dynamic subtest: drm_test_format_block_height_invalid [312.361411] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.085s) [312.374986] Starting dynamic subtest: drm_test_format_block_height_one_plane [312.432436] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.069s) [312.475023] Starting dynamic subtest: drm_test_format_block_height_two_plane [312.521977] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.086s) [312.555421] Starting dynamic subtest: drm_test_format_block_height_three_plane [312.627706] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.102s) [312.643393] Starting dynamic subtest: drm_test_format_block_height_tiled [312.731738] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.100s) [312.779057] Starting dynamic subtest: drm_test_format_min_pitch_invalid [312.824180] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.088s) [312.861118] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp [312.894154] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.067s) [312.920098] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp [312.977693] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.081s) [312.994017] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp [313.074732] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.092s) [313.120244] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp [313.170733] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.091s) [313.212613] Starting dynamic subtest: drm_test_format_min_pitch_two_plane [313.273452] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.098s) [313.288049] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp [313.341137] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.065s) [313.374581] Starting dynamic subtest: drm_test_format_min_pitch_tiled [313.426562] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.082s) [313.428272] Subtest drm_format: SUCCESS (1.623s) [313.681313] [082/133] (715s left) gem_close_race (multigpu-basic-process) [313.798924] Starting subtest: multigpu-basic-process [313.801067] Subtest multigpu-basic-process: SKIP (0.000s) [314.125329] [083/133] (714s left) gem_set_tiling_vs_gtt [314.296906] [084/133] (714s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [314.481189] Starting subtest: planes-downscale-factor-0-5-unity-scaling [314.481909] Starting dynamic subtest: pipe-A [314.572905] Dynamic subtest pipe-A: SUCCESS (0.092s) [314.591017] Starting dynamic subtest: pipe-B [314.769113] Dynamic subtest pipe-B: SUCCESS (0.194s) [314.787397] Starting dynamic subtest: pipe-C [314.982887] Dynamic subtest pipe-C: SUCCESS (0.212s) [315.007918] Starting dynamic subtest: pipe-D [315.234906] Dynamic subtest pipe-D: SUCCESS (0.250s) [315.235789] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.755s) [315.556504] [085/133] (713s left) kms_addfb_basic (basic-y-tiled-legacy) [315.635567] Starting subtest: basic-y-tiled-legacy [315.637245] Subtest basic-y-tiled-legacy: SKIP (0.000s) [315.930471] [086/133] (713s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [316.126817] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [317.432318] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.305s) [317.696797] [087/133] (711s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [317.782415] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [317.784274] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [318.063542] [088/133] (711s left) gem_caching (writes) [318.152120] Starting subtest: writes [322.347745] Subtest writes: SUCCESS (4.194s) [322.547460] [089/133] (706s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [322.625556] Starting subtest: etime-multi-wait-for-submit-unsubmitted [322.728954] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s) [322.897626] [090/133] (706s left) kms_flip (wf_vblank-ts-check) [323.086904] Starting subtest: wf_vblank-ts-check [323.091770] Starting dynamic subtest: A-DP3 [331.215180] Dynamic subtest A-DP3: SUCCESS (8.122s) [331.231309] Starting dynamic subtest: B-DP3 [339.258475] Dynamic subtest B-DP3: SUCCESS (8.040s) [339.273527] Starting dynamic subtest: C-DP3 [347.317364] Dynamic subtest C-DP3: SUCCESS (8.057s) [347.332549] Starting dynamic subtest: D-DP3 [355.371141] Dynamic subtest D-DP3: SUCCESS (8.052s) [355.373300] Subtest wf_vblank-ts-check: SUCCESS (32.282s) [355.735965] [091/133] (673s left) gem_lmem_evict (dontneed-evict-race) [358.630630] Starting subtest: dontneed-evict-race [360.729399] Subtest dontneed-evict-race: SUCCESS (2.098s) [362.608095] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [362.609517] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true [362.612117] [092/133] (666s left) gem_mmap_gtt (medium-copy-odd) [364.262410] Subtest medium-copy-odd: SKIP (0.000s) [364.329205] [FACT gem_mmap_gtt (medium-copy-odd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [364.331949] [FACT gem_mmap_gtt (medium-copy-odd)] new: kernel.kmod_is_loaded.i915: true [364.335354] [093/133] (665s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [364.530239] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [364.535242] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [364.653365] [094/133] (665s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [364.839603] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [364.842033] Starting dynamic subtest: pipe-A-DP-3 [364.863332] Dynamic subtest pipe-A-DP-3: SKIP (0.002s) [364.873867] Starting dynamic subtest: pipe-B-DP-3 [364.894975] Dynamic subtest pipe-B-DP-3: SKIP (0.002s) [364.905397] Starting dynamic subtest: pipe-C-DP-3 [364.930318] Dynamic subtest pipe-C-DP-3: SKIP (0.002s) [364.940568] Starting dynamic subtest: pipe-D-DP-3 [364.963717] Dynamic subtest pipe-D-DP-3: SKIP (0.002s) [364.965181] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.014s) [365.299354] [095/133] (664s left) gem_exec_suspend (basic-s0) [365.395270] Starting subtest: basic-S0 [365.396130] Starting dynamic subtest: smem [386.444786] Dynamic subtest smem: SUCCESS (7.162s) [386.456267] Starting dynamic subtest: lmem0 [407.416055] Dynamic subtest lmem0: SUCCESS (7.070s) [407.417247] Subtest basic-S0: SUCCESS (14.235s) [407.732660] [096/133] (622s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [407.929640] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [409.168233] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.236s) [409.374566] [097/133] (620s left) gem_mmap_offset (bad-extensions) [409.452695] Starting subtest: bad-extensions [409.453812] Subtest bad-extensions: SUCCESS (0.000s) [409.631123] [098/133] (620s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [409.820346] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [409.822395] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s) [410.000296] [099/133] (620s left) gem_mmap_gtt (cpuset-big-copy-odd) [410.077226] Subtest cpuset-big-copy-odd: SKIP (0.000s) [410.145242] [100/133] (619s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [410.344461] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [410.346202] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [410.535722] [101/133] (619s left) kms_psr (fbc-psr2-sprite-render) [410.722981] Subtest fbc-psr2-sprite-render: SKIP (0.000s) [410.779735] [102/133] (619s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [410.972294] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [410.974007] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [411.144564] [103/133] (619s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [411.347360] Starting subtest: crc-primary-basic-y-tiled-ccs [411.348245] Starting dynamic subtest: pipe-A-DP-3 [411.356443] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [411.368018] Starting dynamic subtest: pipe-B-DP-3 [411.376251] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [411.387562] Starting dynamic subtest: pipe-C-DP-3 [411.395640] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [411.407151] Starting dynamic subtest: pipe-D-DP-3 [411.417190] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [411.418823] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.009s) [411.859089] [104/133] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [412.055218] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [412.056933] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [412.249581] [105/133] (618s left) api_intel_bb (add-remove-objects) [412.327549] Starting subtest: add-remove-objects [412.360167] Subtest add-remove-objects: SUCCESS (0.032s) [412.544401] [106/133] (617s left) sysfs_heartbeat_interval (nopreempt) [412.627849] Starting subtest: nopreempt [412.630230] Starting dynamic subtest: vecs0 [416.995167] Dynamic subtest vecs0: SUCCESS (4.364s) [417.007850] Starting dynamic subtest: ccs0 [421.298948] Dynamic subtest ccs0: SUCCESS (4.301s) [421.311208] Starting dynamic subtest: vcs0 [425.513016] Dynamic subtest vcs0: SUCCESS (4.212s) [425.534649] Starting dynamic subtest: bcs0 [429.695486] Dynamic subtest bcs0: SUCCESS (4.180s) [429.711564] Starting dynamic subtest: vecs1 [433.933554] Dynamic subtest vecs1: SUCCESS (4.236s) [433.947296] Starting dynamic subtest: rcs0 [438.275809] Dynamic subtest rcs0: SUCCESS (4.340s) [438.290063] Starting dynamic subtest: vcs1 [442.507502] Dynamic subtest vcs1: SUCCESS (4.230s) [442.508597] Subtest nopreempt: SUCCESS (29.873s) [442.723766] [107/133] (587s left) kms_getfb (getfb2-into-addfb2) [442.910490] Starting subtest: getfb2-into-addfb2 [442.911326] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [443.121684] [108/133] (587s left) gem_close (basic) [443.209203] Starting subtest: basic [443.210143] Subtest basic: SUCCESS (0.000s) [443.401797] [109/133] (587s left) gem_exec_schedule (preemptive-hang) [443.619659] Starting subtest: preemptive-hang [443.621371] Starting dynamic subtest: rcs0 [452.718513] Dynamic subtest rcs0: SUCCESS (9.100s) [452.731240] Starting dynamic subtest: bcs0 [461.670836] Dynamic subtest bcs0: SUCCESS (8.951s) [461.683696] Starting dynamic subtest: vcs0 [470.707635] Dynamic subtest vcs0: SUCCESS (9.034s) [470.720444] Starting dynamic subtest: vcs1 [479.658115] Dynamic subtest vcs1: SUCCESS (8.949s) [479.671038] Starting dynamic subtest: vecs0 [488.694647] Dynamic subtest vecs0: SUCCESS (9.035s) [488.707366] Starting dynamic subtest: vecs1 [497.720746] Dynamic subtest vecs1: SUCCESS (9.023s) [497.733280] Starting dynamic subtest: ccs0 [506.664818] Dynamic subtest ccs0: SUCCESS (8.943s) [506.665701] Subtest preemptive-hang: SUCCESS (63.045s) [506.977594] [110/133] (523s left) i915_drm_fdinfo (virtual-busy-idle) [507.046348] Starting subtest: virtual-busy-idle [507.048198] Subtest virtual-busy-idle: SKIP (0.000s) [507.209006] [111/133] (523s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [507.399962] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [507.401600] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [507.594684] [112/133] (523s left) gem_linear_blits (interruptible) [507.928652] Starting subtest: interruptible [515.007131] Subtest interruptible: SUCCESS (7.080s) [515.212358] [113/133] (515s left) gem_ctx_persistence (engines-mixed) [515.342287] Starting subtest: engines-mixed [515.343390] Starting dynamic subtest: rcs0 [515.472669] Dynamic subtest rcs0: SUCCESS (0.130s) [515.497859] Starting dynamic subtest: bcs0 [515.546027] Dynamic subtest bcs0: SUCCESS (0.071s) [515.588402] Starting dynamic subtest: vcs0 [515.624458] Dynamic subtest vcs0: SUCCESS (0.075s) [515.651681] Starting dynamic subtest: vcs1 [515.709121] Dynamic subtest vcs1: SUCCESS (0.082s) [515.753020] Starting dynamic subtest: vecs0 [515.777442] Dynamic subtest vecs0: SUCCESS (0.065s) [515.798970] Starting dynamic subtest: vecs1 [515.839820] Dynamic subtest vecs1: SUCCESS (0.060s) [515.865947] Starting dynamic subtest: ccs0 [515.916350] Dynamic subtest ccs0: SUCCESS (0.074s) [515.917329] Subtest engines-mixed: SUCCESS (0.575s) [516.127134] [114/133] (515s left) perf_pmu (init-wait) [516.196899] Starting subtest: init-wait [516.197826] Starting dynamic subtest: rcs0 [516.200239] Dynamic subtest rcs0: SUCCESS (0.003s) [516.214504] Starting dynamic subtest: bcs0 [516.215422] Dynamic subtest bcs0: SUCCESS (0.001s) [516.227752] Starting dynamic subtest: vcs0 [516.228566] Dynamic subtest vcs0: SUCCESS (0.001s) [516.241110] Starting dynamic subtest: vcs1 [516.242246] Dynamic subtest vcs1: SUCCESS (0.001s) [516.254712] Starting dynamic subtest: vecs0 [516.255880] Dynamic subtest vecs0: SUCCESS (0.001s) [516.268275] Starting dynamic subtest: vecs1 [516.269539] Dynamic subtest vecs1: SUCCESS (0.001s) [516.281969] Starting dynamic subtest: ccs0 [516.283196] Dynamic subtest ccs0: SUCCESS (0.001s) [516.284444] Subtest init-wait: SUCCESS (0.014s) [516.360737] [115/133] (514s left) gem_exec_reloc (basic-gtt-cpu-active) [516.446500] Subtest basic-gtt-cpu-active: SKIP (0.000s) [516.521586] [116/133] (514s left) kms_pm_lpsp (screens-disabled) [517.726278] Starting subtest: screens-disabled [517.728073] Subtest screens-disabled: SKIP (0.000s) [517.900262] [117/133] (513s left) kms_flip (flip-vs-expired-vblank-interruptible) [518.097579] Starting subtest: flip-vs-expired-vblank-interruptible [518.102498] Starting dynamic subtest: A-DP3 [525.968449] Dynamic subtest A-DP3: SUCCESS (7.866s) [526.009462] Starting dynamic subtest: B-DP3 [533.752391] Dynamic subtest B-DP3: SUCCESS (7.779s) [533.766797] Starting dynamic subtest: C-DP3 [541.502027] Dynamic subtest C-DP3: SUCCESS (7.748s) [541.543451] Starting dynamic subtest: D-DP3 [549.259623] Dynamic subtest D-DP3: SUCCESS (7.752s) [549.268249] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (31.172s) [549.623861] [118/133] (481s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [549.815308] Starting subtest: psr-1p-primscrn-cur-indfb-move [549.817062] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [550.002203] [119/133] (481s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [550.186460] Starting subtest: plane-all-modeset-transition-internal-panels [550.188193] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s) [550.366697] [120/133] (481s left) gem_userptr_blits (stress-mm) [550.455540] Starting subtest: stress-mm [555.823445] Subtest stress-mm: SUCCESS (5.369s) [556.032627] [121/133] (475s left) syncobj_eventfd (invalid-bad-flags) [556.116600] Starting subtest: invalid-bad-flags [556.117529] Subtest invalid-bad-flags: SUCCESS (0.000s) [556.250832] [122/133] (475s left) kms_addfb_basic (framebuffer-vs-set-tiling) [556.329634] Starting subtest: framebuffer-vs-set-tiling [556.331360] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [556.610697] [123/133] (475s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [556.801220] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [556.802983] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [557.002949] [124/133] (474s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [557.083375] Starting subtest: multi-wait-for-submit-available-submitted-signaled [557.084311] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [557.248643] [125/133] (474s left) kms_flip (2x-modeset-vs-vblank-race) [557.433109] Starting subtest: 2x-modeset-vs-vblank-race [557.448447] Subtest 2x-modeset-vs-vblank-race: SKIP (0.015s) [557.635535] [126/133] (474s left) i915_query (query-regions-garbage-items) [557.712441] Starting subtest: query-regions-garbage-items [557.713327] Subtest query-regions-garbage-items: SUCCESS (0.000s) [557.917945] [127/133] (474s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [557.995358] Subtest flip-primary-invalidate-overlay: SKIP (0.000s) [558.066600] [128/133] (474s left) gem_exec_balancer (full-late) [558.155937] Starting subtest: full-late [560.198300] Subtest full-late: SUCCESS (2.042s) [560.624096] [129/133] (471s left) gem_exec_reloc (basic-write-wc) [560.704234] Subtest basic-write-wc: SKIP (0.000s) [560.784151] [130/133] (471s left) kms_force_connector_basic (force-load-detect) [560.892922] Starting subtest: force-load-detect [560.894654] Subtest force-load-detect: SKIP (0.000s) [561.150935] [131/133] (471s left) kms_chamelium_hpd (hdmi-hpd-fast) [561.416688] Subtest hdmi-hpd-fast: SKIP (0.000s) [561.590649] [132/133] (470s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [561.775249] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [561.776121] Starting dynamic subtest: pipe-A-valid-mode [563.622376] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.843s) [563.623732] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (1.847s) [563.936578] [133/133] (468s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [564.124942] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [564.126565] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [564.283991] 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.