[60.791129] Initializing watchdogs [60.791174] /dev/watchdog0 [60.811044] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [60.815219] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.817379] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.820834] [001/133] (960s left) kms_psr (psr2-sprite-mmap-cpu) [60.951809] Starting subtest: psr2-sprite-mmap-cpu [60.954513] Starting dynamic subtest: eDP-1 [62.667084] Dynamic subtest eDP-1: SUCCESS (1.710s) [62.669107] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.710s) [63.544945] [002/133] (957s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [63.655290] Starting subtest: crc-primary-suspend-y-tiled-ccs [63.657618] Starting dynamic subtest: pipe-A-eDP-1 [63.666636] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [63.677451] Starting dynamic subtest: pipe-B-eDP-1 [63.686621] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [63.693317] Starting dynamic subtest: pipe-C-eDP-1 [63.701877] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [63.708051] Starting dynamic subtest: pipe-D-eDP-1 [63.716608] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [63.720695] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.003s) [65.939776] [003/133] (955s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [66.317385] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [67.135224] [004/133] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt) [67.370224] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt [74.199097] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.826s) [74.358880] [005/133] (947s left) gem_exec_schedule (implicit-read-write) [74.440549] Starting subtest: implicit-read-write [74.442551] Starting dynamic subtest: rcs0 [74.540611] Dynamic subtest rcs0: SUCCESS (0.109s) [74.550929] Starting dynamic subtest: vcs0 [74.625863] Dynamic subtest vcs0: SUCCESS (0.085s) [74.636917] Starting dynamic subtest: vcs1 [74.698702] Dynamic subtest vcs1: SUCCESS (0.073s) [74.707939] Starting dynamic subtest: vecs0 [74.771073] Dynamic subtest vecs0: SUCCESS (0.072s) [74.781358] Starting dynamic subtest: ccs0 [74.853098] Dynamic subtest ccs0: SUCCESS (0.082s) [74.855647] Subtest implicit-read-write: SUCCESS (0.421s) [76.038704] [006/133] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [76.132166] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [76.136106] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [76.249660] [007/133] (945s left) gem_exec_whisper (basic-queues) [76.325922] Starting subtest: basic-queues [81.536856] Subtest basic-queues: SUCCESS (5.210s) [81.727794] [008/133] (939s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [81.835715] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [81.839851] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [81.955516] [009/133] (939s left) kms_psr (pr-cursor-blt) [82.053407] Starting subtest: pr-cursor-blt [82.058034] Subtest pr-cursor-blt: SKIP (0.000s) [82.131853] [010/133] (939s left) vgem_basic (mmap) [82.210342] Starting subtest: mmap [82.217969] Subtest mmap: SUCCESS (0.010s) [82.298170] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true [82.301128] [011/133] (939s left) gem_exec_nop (basic-parallel) [82.378872] Starting subtest: basic-parallel [98.836414] Subtest basic-parallel: SUCCESS (16.466s) [99.101553] [012/133] (922s left) drm_read (empty-nonblock) [99.291360] Starting subtest: empty-nonblock [99.293793] Subtest empty-nonblock: SUCCESS (0.000s) [99.458216] [013/133] (922s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [99.558952] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [99.561528] Starting dynamic subtest: pipe-A-eDP-1 [99.990098] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s) [99.999379] Starting dynamic subtest: pipe-B-eDP-1 [101.356332] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.358s) [101.366792] Starting dynamic subtest: pipe-C-eDP-1 [102.704348] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.347s) [102.717128] Starting dynamic subtest: pipe-D-eDP-1 [104.014405] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.311s) [104.016396] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.428s) [105.236312] [014/133] (916s left) perf_pmu (init-busy) [105.284731] Starting subtest: init-busy [105.287104] Starting dynamic subtest: rcs0 [105.289533] Dynamic subtest rcs0: SUCCESS (0.001s) [105.299135] Starting dynamic subtest: bcs0 [105.301030] Dynamic subtest bcs0: SUCCESS (0.000s) [105.308204] Starting dynamic subtest: vcs0 [105.310070] Dynamic subtest vcs0: SUCCESS (0.001s) [105.317133] Starting dynamic subtest: vcs1 [105.319040] Dynamic subtest vcs1: SUCCESS (0.001s) [105.325886] Starting dynamic subtest: vecs0 [105.327836] Dynamic subtest vecs0: SUCCESS (0.001s) [105.334543] Starting dynamic subtest: ccs0 [105.336451] Dynamic subtest ccs0: SUCCESS (0.000s) [105.338330] Subtest init-busy: SUCCESS (0.005s) [105.408119] [015/133] (916s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [105.518730] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [105.521111] Starting dynamic subtest: pipe-A-default-mode [108.269393] Dynamic subtest pipe-A-default-mode: SUCCESS (2.750s) [108.271761] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.751s) [109.120686] [016/133] (912s left) syncobj_eventfd (invalid-bad-flags) [109.185050] Starting subtest: invalid-bad-flags [109.187326] Subtest invalid-bad-flags: SUCCESS (0.000s) [109.306037] [017/133] (912s left) syncobj_wait (wait-for-submit-delayed-submit) [109.368144] Starting subtest: wait-for-submit-delayed-submit [109.470901] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s) [109.556061] [018/133] (912s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [109.942425] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [110.715657] [019/133] (911s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping) [110.812175] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping [110.816270] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s) [110.906466] [020/133] (911s left) perf_pmu (semaphore-wait) [110.949048] Starting subtest: semaphore-wait [110.951314] Starting dynamic subtest: rcs0 [111.462963] Dynamic subtest rcs0: SUCCESS (0.513s) [111.471995] Starting dynamic subtest: bcs0 [111.977436] Dynamic subtest bcs0: SUCCESS (0.513s) [111.988355] Starting dynamic subtest: vcs0 [112.491101] Dynamic subtest vcs0: SUCCESS (0.512s) [112.501739] Starting dynamic subtest: vcs1 [113.004439] Dynamic subtest vcs1: SUCCESS (0.511s) [113.014986] Starting dynamic subtest: vecs0 [113.516939] Dynamic subtest vecs0: SUCCESS (0.511s) [113.527483] Starting dynamic subtest: ccs0 [114.031384] Dynamic subtest ccs0: SUCCESS (0.512s) [114.034051] Subtest semaphore-wait: SUCCESS (3.083s) [114.180329] [021/133] (907s left) gem_mmap_gtt (cpuset-big-copy) [114.251980] Subtest cpuset-big-copy: SKIP (0.000s) [114.320232] [022/133] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [114.426222] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [114.430346] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [114.539835] [023/133] (907s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [114.640665] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [114.645266] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [114.759035] [024/133] (907s left) gem_exec_gttfill (engines) [114.826690] Starting subtest: engines [114.829074] Starting dynamic subtest: rcs0 [137.594367] Dynamic subtest rcs0: SUCCESS (22.767s) [137.606830] Starting dynamic subtest: bcs0 [160.853892] Dynamic subtest bcs0: SUCCESS (23.256s) [160.864379] Starting dynamic subtest: vcs0 [184.093464] Dynamic subtest vcs0: SUCCESS (23.236s) [184.103992] Starting dynamic subtest: vcs1 [207.344825] Dynamic subtest vcs1: SUCCESS (23.250s) [207.353295] Starting dynamic subtest: vecs0 [230.635825] Dynamic subtest vecs0: SUCCESS (23.288s) [230.650039] Starting dynamic subtest: ccs0 [253.926438] Dynamic subtest ccs0: SUCCESS (23.289s) [253.929530] Subtest engines: SUCCESS (139.091s) [254.124240] [025/133] (768s left) kms_async_flips (test-cursor-atomic) [254.259817] Starting subtest: test-cursor-atomic [254.264108] Subtest test-cursor-atomic: SKIP (0.000s) [255.458882] [026/133] (766s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy) [255.585028] Starting subtest: 2x-flip-vs-cursor-legacy [255.589327] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s) [255.742424] [027/133] (766s left) vgem_basic (debugfs) [255.796064] Starting subtest: debugfs [255.798357] Subtest debugfs: SUCCESS (0.000s) [255.863593] [028/133] (766s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [255.971639] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [255.975809] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.001s) [256.104333] [029/133] (766s left) kms_plane_alpha_blend (alpha-basic) [256.204327] Starting subtest: alpha-basic [256.484988] Starting dynamic subtest: pipe-A-eDP-1 [258.395613] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.908s) [258.421071] Starting dynamic subtest: pipe-D-eDP-1 [261.122453] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.708s) [261.124424] Subtest alpha-basic: SUCCESS (4.919s) [261.926579] [030/133] (760s left) gen7_exec_parse (batch-without-end) [261.977132] Subtest batch-without-end: SKIP (0.000s) [262.050938] [031/133] (760s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [262.146807] Starting subtest: async-flip-with-page-flip-events-tiled [262.515736] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [265.298503] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.781s) [265.308189] Starting dynamic subtest: pipe-A-eDP-1-4 [267.461974] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.163s) [267.470544] Starting dynamic subtest: pipe-A-eDP-1-4 [269.472463] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [269.483475] Starting dynamic subtest: pipe-A-eDP-1-x [271.651644] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s) [272.031296] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [274.829709] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.808s) [274.841298] Starting dynamic subtest: pipe-B-eDP-1-4 [277.016293] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s) [277.025644] Starting dynamic subtest: pipe-B-eDP-1-4 [279.025445] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s) [279.033775] Starting dynamic subtest: pipe-B-eDP-1-x [281.215664] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [281.585027] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [284.350284] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.771s) [284.358803] Starting dynamic subtest: pipe-C-eDP-1-4 [286.514893] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.164s) [286.523108] Starting dynamic subtest: pipe-C-eDP-1-4 [288.524687] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [288.533209] Starting dynamic subtest: pipe-C-eDP-1-x [290.703048] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [291.063769] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [293.873851] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.815s) [293.887403] Starting dynamic subtest: pipe-D-eDP-1-4 [296.037532] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.162s) [296.046540] Starting dynamic subtest: pipe-D-eDP-1-4 [298.047900] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s) [298.060662] Starting dynamic subtest: pipe-D-eDP-1-x [300.226847] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [300.229743] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.079s) [301.378060] [032/133] (721s left) i915_drm_fdinfo (busy-idle-check-all) [301.425788] Starting subtest: busy-idle-check-all [301.427693] Starting dynamic subtest: rcs0 [301.432399] Dynamic subtest rcs0: SKIP (0.004s) [301.444352] Starting dynamic subtest: bcs0 [301.448769] Dynamic subtest bcs0: SKIP (0.000s) [301.458989] Starting dynamic subtest: vcs0 [301.463247] Dynamic subtest vcs0: SKIP (0.000s) [301.471774] Starting dynamic subtest: vcs1 [301.475800] Dynamic subtest vcs1: SKIP (0.000s) [301.482988] Starting dynamic subtest: vecs0 [301.487044] Dynamic subtest vecs0: SKIP (0.000s) [301.494167] Starting dynamic subtest: ccs0 [301.498282] Dynamic subtest ccs0: SKIP (0.000s) [301.502225] Subtest busy-idle-check-all: SKIP (0.007s) [301.536977] [033/133] (721s left) syncobj_wait (invalid-signal-illegal-handle) [301.615164] Starting subtest: invalid-signal-illegal-handle [301.617440] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [301.724993] [034/133] (720s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [301.775231] Starting subtest: multi-wait-for-submit-unsubmitted [301.882109] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.107s) [301.971597] [035/133] (720s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [302.087068] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [303.054509] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.967s) [303.199143] [036/133] (719s left) gem_userptr_blits (sync-unmap-cycles) [303.266826] Starting subtest: sync-unmap-cycles [308.642900] Subtest sync-unmap-cycles: SUCCESS (5.371s) [308.783519] [037/133] (713s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [308.887982] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [308.889909] Starting dynamic subtest: pipe-A-eDP-1 [308.908454] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [308.916859] Starting dynamic subtest: pipe-B-eDP-1 [308.934290] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [308.941541] Starting dynamic subtest: pipe-C-eDP-1 [308.958844] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [308.966450] Starting dynamic subtest: pipe-D-eDP-1 [308.984239] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [308.987695] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s) [311.154744] [038/133] (711s left) kms_addfb_basic (unused-pitches) [311.203827] Starting subtest: unused-pitches [311.206113] Subtest unused-pitches: SUCCESS (0.000s) [311.368893] [039/133] (711s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [311.464678] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [311.469168] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [311.593781] [040/133] (711s left) gem_exec_flush (basic-wb-rw-before-default) [311.665938] Starting subtest: basic-wb-rw-before-default [317.114890] Subtest basic-wb-rw-before-default: SUCCESS (5.450s) [317.316529] [041/133] (705s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [317.437568] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [321.910126] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.476s) [323.066452] [042/133] (699s left) i915_pm_rpm (debugfs-forcewake-user) [325.094313] Starting subtest: debugfs-forcewake-user [336.494254] Subtest debugfs-forcewake-user: SUCCESS (11.404s) [336.888201] [043/133] (686s left) kms_psr (fbc-pr-dpms) [336.984868] Starting subtest: fbc-pr-dpms [336.988739] Subtest fbc-pr-dpms: SKIP (0.000s) [337.067434] [044/133] (685s left) kms_force_connector_basic (force-load-detect) [337.154902] Starting subtest: force-load-detect [337.159709] Subtest force-load-detect: SKIP (0.000s) [337.277049] [045/133] (685s left) gem_mmap_wc (write) [337.338563] Subtest write: SKIP (0.000s) [337.405853] [046/133] (685s left) gem_exec_schedule (preempt-queue-contexts-chain) [337.489471] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [337.789912] [047/133] (685s left) gem_ccs (ctrl-surf-copy-new-ctx) [337.855969] Starting subtest: ctrl-surf-copy-new-ctx [337.860582] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [337.993475] [048/133] (685s left) prime_mmap (test_aperture_limit) [338.063249] Starting subtest: test_aperture_limit [338.065466] Starting dynamic subtest: test_aperture_limit-smem [338.072621] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s) [338.076697] Subtest test_aperture_limit: SKIP (0.008s) [338.192113] [049/133] (684s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [338.297649] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [338.301710] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [338.377860] [050/133] (684s left) gem_exec_alignment (forked) [338.445302] Starting subtest: forked [376.014434] Subtest forked: SUCCESS (37.568s) [376.102390] [051/133] (647s left) gem_fenced_exec_thrash (too-many-fences) [376.195901] Subtest too-many-fences: SKIP (0.000s) [376.275828] [052/133] (647s left) kms_pm_dc (dc6-psr) [377.422776] Starting subtest: dc6-psr [380.321664] Subtest dc6-psr: SUCCESS (2.896s) [381.231484] [053/133] (642s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [381.338331] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [387.993405] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.658s) [388.162762] [054/133] (635s left) prime_mmap (test_forked) [388.240673] Starting subtest: test_forked [388.243124] Starting dynamic subtest: test_forked-smem [388.276390] Dynamic subtest test_forked-smem: SUCCESS (0.036s) [388.278814] Subtest test_forked: SUCCESS (0.038s) [388.414530] [055/133] (635s left) gem_lmem_swapping (parallel-random-engines) [388.451660] Subtest parallel-random-engines: SKIP (0.000s) [388.496382] [056/133] (634s left) kms_color (ctm-0-25) [388.596041] Starting subtest: ctm-0-25 [388.597938] Starting dynamic subtest: pipe-A-eDP-1 [392.062877] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s) [392.071375] Starting dynamic subtest: pipe-B-eDP-1 [396.325749] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.263s) [396.333824] Starting dynamic subtest: pipe-C-eDP-1 [400.398731] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.071s) [400.407263] Starting dynamic subtest: pipe-D-eDP-1 [404.384488] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.984s) [404.386895] Subtest ctm-0-25: SUCCESS (15.788s) [405.224087] [057/133] (618s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [405.349022] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [405.353439] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [405.469140] [058/133] (618s left) kms_psr (psr-primary-mmap-cpu) [405.567347] Starting subtest: psr-primary-mmap-cpu [405.569571] Starting dynamic subtest: eDP-1 [407.299395] Dynamic subtest eDP-1: SUCCESS (1.733s) [407.301734] Subtest psr-primary-mmap-cpu: SUCCESS (1.734s) [408.202285] [059/133] (615s left) api_intel_bb (simple-bb) [408.271541] Starting subtest: simple-bb [408.276423] Subtest simple-bb: SUCCESS (0.005s) [408.420708] [060/133] (615s left) kms_dither (fb-8bpc-vs-panel-6bpc) [408.514178] Starting subtest: fb-8bpc-vs-panel-6bpc [408.516426] Starting dynamic subtest: pipe-A-eDP-1 [409.956252] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.443s) [409.958675] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.444s) [410.834107] [061/133] (612s left) kms_vblank (wait-busy) [410.924281] Starting subtest: wait-busy [410.926466] Starting dynamic subtest: pipe-A-eDP-1 [412.805466] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s) [412.819313] Starting dynamic subtest: pipe-D-eDP-1 [415.384879] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.577s) [415.387282] Subtest wait-busy: SUCCESS (4.461s) [416.191192] [062/133] (607s left) gem_mmap_offset (open-flood) [416.248183] Starting subtest: open-flood [437.734941] Subtest open-flood: SUCCESS (21.489s) [437.886080] [063/133] (585s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [437.985703] Starting subtest: pr-overlay-primary-update-sf-dmg-area [437.989156] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [438.072281] [064/133] (585s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [438.167394] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [438.171179] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [438.293910] [065/133] (585s left) kms_plane_lowres (tiling-4) [438.391494] Starting subtest: tiling-4 [438.393437] Starting dynamic subtest: pipe-A-eDP-1 [438.397355] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [438.686425] Starting dynamic subtest: pipe-B-eDP-1 [438.691207] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [438.700303] Starting dynamic subtest: pipe-C-eDP-1 [438.705254] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [438.719557] Starting dynamic subtest: pipe-D-eDP-1 [438.723811] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [438.728027] Subtest tiling-4: SKIP (0.293s) [439.533252] [066/133] (584s left) kms_flip (plain-flip-fb-recreate) [439.638714] Starting subtest: plain-flip-fb-recreate [439.641053] Starting dynamic subtest: A-eDP1 [448.497185] Dynamic subtest A-eDP1: SUCCESS (8.861s) [448.510728] Starting dynamic subtest: B-eDP1 [457.323057] Dynamic subtest B-eDP1: SUCCESS (8.824s) [457.332425] Starting dynamic subtest: C-eDP1 [466.139874] Dynamic subtest C-eDP1: SUCCESS (8.815s) [466.149555] Starting dynamic subtest: D-eDP1 [474.979918] Dynamic subtest D-eDP1: SUCCESS (8.839s) [474.983990] Subtest plain-flip-fb-recreate: SUCCESS (35.348s) [476.167481] [067/133] (547s left) kms_getfb (getfb2-handle-not-fb) [476.265328] Starting subtest: getfb2-handle-not-fb [476.267664] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [476.401090] [068/133] (547s left) gem_pxp (display-protected-crc) [476.524594] Starting subtest: display-protected-crc [478.252694] Subtest display-protected-crc: SUCCESS (1.731s) [478.394069] [069/133] (545s left) kms_big_fb (linear-64bpp-rotate-90) [478.501103] Starting subtest: linear-64bpp-rotate-90 [478.520507] Subtest linear-64bpp-rotate-90: SKIP (0.019s) [478.655187] [070/133] (545s left) gem_mmap_gtt (big-bo-tiledy) [478.726368] Subtest big-bo-tiledY: SKIP (0.000s) [478.794198] [071/133] (545s left) kms_cursor_crc (cursor-offscreen-64x64) [478.973954] Starting subtest: cursor-offscreen-64x64 [478.978636] Starting dynamic subtest: pipe-A-eDP-1 [480.925530] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s) [480.957582] Starting dynamic subtest: pipe-D-eDP-1 [483.559508] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.609s) [483.561816] Subtest cursor-offscreen-64x64: SUCCESS (4.587s) [484.459295] [072/133] (539s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [484.564097] Starting subtest: plane-downscale-factor-0-5-with-rotation [484.566354] Starting dynamic subtest: pipe-A [484.584183] Dynamic subtest pipe-A: SKIP (0.015s) [484.595868] Starting dynamic subtest: pipe-B [484.611379] Dynamic subtest pipe-B: SKIP (0.027s) [484.620076] Starting dynamic subtest: pipe-C [484.637509] Dynamic subtest pipe-C: SKIP (0.028s) [484.646196] Starting dynamic subtest: pipe-D [484.666566] Dynamic subtest pipe-D: SKIP (0.028s) [484.670356] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.099s) [484.788053] [073/133] (539s left) kms_rotation_crc (cursor-rotation-180) [484.886646] Starting subtest: cursor-rotation-180 [486.405082] Subtest cursor-rotation-180: SUCCESS (1.520s) [487.610605] [074/133] (536s left) i915_pm_freq_api (freq-reset-multiple) [487.676333] Starting subtest: freq-reset-multiple [487.678664] Starting dynamic subtest: gt0 [497.404310] Dynamic subtest gt0: SUCCESS (9.724s) [497.413892] Starting dynamic subtest: gt1 [505.738083] Dynamic subtest gt1: SUCCESS (8.333s) [505.740879] Subtest freq-reset-multiple: SUCCESS (18.059s) [505.827066] [075/133] (518s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [505.897291] Starting subtest: etime-multi-wait-all-submitted-signaled [506.002166] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s) [506.090732] [076/133] (518s left) gem_ctx_persistence (engines-hostile-preempt) [506.148665] Starting subtest: engines-hostile-preempt [506.151290] Starting dynamic subtest: rcs0 [506.248616] Dynamic subtest rcs0: SUCCESS (0.100s) [506.260282] Starting dynamic subtest: bcs0 [506.320902] Dynamic subtest bcs0: SUCCESS (0.070s) [506.333135] Starting dynamic subtest: vcs0 [507.940520] Dynamic subtest vcs0: SUCCESS (1.616s) [507.951772] Starting dynamic subtest: vcs1 [509.892331] Dynamic subtest vcs1: SUCCESS (1.950s) [509.904105] Starting dynamic subtest: vecs0 [511.875279] Dynamic subtest vecs0: SUCCESS (1.981s) [511.886994] Starting dynamic subtest: ccs0 [511.974973] Dynamic subtest ccs0: SUCCESS (0.099s) [511.977875] Subtest engines-hostile-preempt: SUCCESS (5.827s) [512.065482] [077/133] (512s left) gem_exec_create (basic) [512.119801] Starting subtest: basic [512.122132] Starting dynamic subtest: smem [515.924692] Dynamic subtest smem: SUCCESS (3.807s) [515.927224] Subtest basic: SUCCESS (3.809s) [516.126274] [078/133] (508s left) syncobj_timeline (multi-wait-available-submitted-signaled) [516.186747] Starting subtest: multi-wait-available-submitted-signaled [516.188951] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [516.317746] [079/133] (508s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [516.418065] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [516.422532] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [516.511635] [080/133] (507s left) syncobj_timeline (wait-delayed-signal) [516.564643] Starting subtest: wait-delayed-signal [516.667668] Subtest wait-delayed-signal: SUCCESS (0.103s) [516.757664] [081/133] (507s left) api_intel_allocator (two-level-inception-interruptible) [516.812302] Starting subtest: two-level-inception-interruptible [522.214947] Subtest two-level-inception-interruptible: SUCCESS (5.404s) [522.337385] [082/133] (502s left) gem_ctx_persistence (idempotent) [522.406967] Starting subtest: idempotent [522.409444] Subtest idempotent: SUCCESS (0.000s) [522.553421] [083/133] (502s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [522.614386] Starting subtest: y-tiled-to-vebox-x-tiled [522.619395] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [522.813153] [084/133] (501s left) kms_feature_discovery (psr1) [522.928160] Starting subtest: psr1 [522.930415] Subtest psr1: SUCCESS (0.000s) [523.017704] [085/133] (501s left) perf (invalid-remove-userspace-config) [523.172846] Starting subtest: invalid-remove-userspace-config [523.182094] Subtest invalid-remove-userspace-config: SUCCESS (0.009s) [523.223942] [086/133] (501s left) kms_big_fb (x-tiled-8bpp-rotate-270) [523.338389] Starting subtest: x-tiled-8bpp-rotate-270 [523.359760] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s) [523.530085] [087/133] (501s left) perf_pmu (busy-hang) [523.569583] Starting subtest: busy-hang [523.571999] Starting dynamic subtest: rcs0 [524.885854] Dynamic subtest rcs0: SUCCESS (1.314s) [524.897227] Starting dynamic subtest: bcs0 [526.157350] Dynamic subtest bcs0: SUCCESS (1.273s) [526.168800] Starting dynamic subtest: vcs0 [528.405501] Dynamic subtest vcs0: SUCCESS (2.246s) [528.416643] Starting dynamic subtest: vcs1 [530.399166] Dynamic subtest vcs1: SUCCESS (1.989s) [530.409411] Starting dynamic subtest: vecs0 [532.444070] Dynamic subtest vecs0: SUCCESS (2.046s) [532.455848] Starting dynamic subtest: ccs0 [533.701176] Dynamic subtest ccs0: SUCCESS (1.255s) [533.703620] Subtest busy-hang: SUCCESS (10.134s) [533.820203] [088/133] (490s left) gen3_render_linear_blits [533.948349] [089/133] (490s left) gem_eio (in-flight-10ms) [534.181871] Starting subtest: in-flight-10ms [542.966806] Subtest in-flight-10ms: SUCCESS (8.784s) [543.182838] [090/133] (481s left) perf (per-context-mode-unprivileged) [543.275153] Starting subtest: per-context-mode-unprivileged [543.279470] Subtest per-context-mode-unprivileged: SKIP (0.000s) [543.319409] [091/133] (481s left) syncobj_wait (wait-all-for-submit-snapshot) [543.385818] Starting subtest: wait-all-for-submit-snapshot [543.466652] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s) [543.554537] [092/133] (481s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [543.650323] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [543.654522] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [543.760062] [093/133] (481s left) syncobj_timeline (invalid-signal-illegal-handle) [543.817930] Starting subtest: invalid-signal-illegal-handle [543.819636] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [543.937286] [094/133] (481s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [544.044725] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [544.048425] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [544.162185] [095/133] (480s left) kms_rmfb (close-fd) [544.263481] Starting subtest: close-fd [544.265167] Starting dynamic subtest: pipe-A-eDP-1 [544.371739] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s) [544.381886] Starting dynamic subtest: pipe-B-eDP-1 [545.557069] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.183s) [545.567771] Starting dynamic subtest: pipe-C-eDP-1 [546.684416] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s) [546.694906] Starting dynamic subtest: pipe-D-eDP-1 [547.832850] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s) [547.834872] Subtest close-fd: SUCCESS (3.568s) [549.034764] [096/133] (476s left) syncobj_timeline (wait-all-interrupted) [549.104762] Starting subtest: wait-all-interrupted [549.207076] Subtest wait-all-interrupted: SUCCESS (0.102s) [549.303966] [097/133] (475s left) gem_exec_params (invalid-bsd2-flag-on-render) [549.371065] Starting subtest: invalid-bsd2-flag-on-render [549.373236] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s) [549.497251] [098/133] (475s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [549.587124] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [549.589286] Starting dynamic subtest: pipe-A [549.606854] Dynamic subtest pipe-A: SKIP (0.017s) [549.616798] Starting dynamic subtest: pipe-B [549.636622] Dynamic subtest pipe-B: SKIP (0.029s) [549.646056] Starting dynamic subtest: pipe-C [549.665429] Dynamic subtest pipe-C: SKIP (0.029s) [549.674808] Starting dynamic subtest: pipe-D [549.695923] Dynamic subtest pipe-D: SKIP (0.028s) [549.699703] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.105s) [549.831112] [099/133] (475s left) kms_pm_rpm (system-suspend-idle) [552.074579] Starting subtest: system-suspend-idle [571.685309] Subtest system-suspend-idle: SUCCESS (4.766s) [572.094416] [100/133] (453s left) kms_content_protection (atomic-dpms) [572.250850] Starting subtest: atomic-dpms [572.255489] Subtest atomic-dpms: SKIP (0.000s) [572.402213] [101/133] (452s left) gem_softpin (zero) [572.478573] Starting subtest: zero [572.483529] Subtest zero: SUCCESS (0.003s) [572.632067] [102/133] (452s left) gem_exec_capture (capture) [572.698552] Starting subtest: capture [572.700872] Starting dynamic subtest: rcs0-smem [573.538241] Dynamic subtest rcs0-smem: SUCCESS (0.828s) [573.548557] Starting dynamic subtest: bcs0-smem [574.371670] Dynamic subtest bcs0-smem: SUCCESS (0.824s) [574.381333] Starting dynamic subtest: vcs0-smem [575.198529] Dynamic subtest vcs0-smem: SUCCESS (0.817s) [575.208065] Starting dynamic subtest: vcs1-smem [576.521344] Dynamic subtest vcs1-smem: SUCCESS (1.313s) [576.530993] Starting dynamic subtest: vecs0-smem [577.425821] Dynamic subtest vecs0-smem: FAIL (0.837s) [577.435768] Starting dynamic subtest: ccs0-smem [578.704899] Dynamic subtest ccs0-smem: SUCCESS (1.328s) [578.707281] Subtest capture: FAIL (5.952s) [578.857215] [103/133] (446s left) kms_lease (possible-crtcs-filtering) [578.954741] Starting subtest: possible-crtcs-filtering [578.962656] Subtest possible-crtcs-filtering: SUCCESS (0.006s) [579.103927] [104/133] (446s left) gem_tiled_blits (interruptible) [579.171585] Subtest interruptible: SKIP (0.000s) [579.234767] [105/133] (446s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [579.342118] Starting subtest: fbcpsr-stridechange [585.480186] Subtest fbcpsr-stridechange: SUCCESS (6.118s) [585.599068] [106/133] (439s left) kms_psr (fbc-psr-sprite-mmap-gtt) [585.701881] Starting subtest: fbc-psr-sprite-mmap-gtt [585.704161] Starting dynamic subtest: eDP-1 [585.708576] Dynamic subtest eDP-1: SKIP (0.000s) [585.712973] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s) [585.784476] [107/133] (439s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [585.910621] Starting subtest: cursor-vs-flip-varying-size [616.606175] Subtest cursor-vs-flip-varying-size: SUCCESS (30.679s) [617.512897] [108/133] (408s left) i915_query (engine-info-invalid) [617.579172] Starting subtest: engine-info-invalid [617.581124] Subtest engine-info-invalid: SUCCESS (0.000s) [617.690750] [109/133] (407s left) kms_sequence (get-forked) [617.775067] Starting subtest: get-forked [617.777421] Starting dynamic subtest: pipe-A-eDP-1 [619.652162] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s) [619.663676] Starting dynamic subtest: pipe-B-eDP-1 [622.241002] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.587s) [622.250977] Starting dynamic subtest: pipe-C-eDP-1 [624.750011] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.507s) [624.761182] Starting dynamic subtest: pipe-D-eDP-1 [627.251699] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.500s) [627.254009] Subtest get-forked: SUCCESS (9.473s) [628.121198] [110/133] (397s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [628.225863] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [635.755451] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.531s) [635.893363] [111/133] (389s left) kms_cursor_crc (cursor-sliding-32x10) [636.073841] Starting subtest: cursor-sliding-32x10 [636.114897] Subtest cursor-sliding-32x10: SKIP (0.039s) [636.419574] [112/133] (389s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [636.526095] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [636.530183] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [636.663203] [113/133] (389s left) kms_invalid_mode (zero-clock) [636.764087] Starting subtest: zero-clock [636.765934] Starting dynamic subtest: pipe-A-eDP-1 [637.048675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [637.059318] Starting dynamic subtest: pipe-B-eDP-1 [637.061240] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [637.071033] Starting dynamic subtest: pipe-C-eDP-1 [637.073194] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [637.083012] Starting dynamic subtest: pipe-D-eDP-1 [637.085271] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [637.087477] Subtest zero-clock: SUCCESS (0.290s) [637.886074] [114/133] (388s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [637.984825] Starting subtest: ccs-on-another-bo-y-tiled-ccs [637.986978] Starting dynamic subtest: pipe-A-eDP-1 [638.009083] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [638.020722] Starting dynamic subtest: pipe-B-eDP-1 [638.040931] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [638.050283] Starting dynamic subtest: pipe-C-eDP-1 [638.070970] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [638.080240] Starting dynamic subtest: pipe-D-eDP-1 [638.101158] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [638.104986] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s) [640.250290] [115/133] (385s left) kms_psr (fbc-pr-sprite-plane-onoff) [640.348905] Starting subtest: fbc-pr-sprite-plane-onoff [640.353329] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s) [640.436796] [116/133] (385s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [640.541904] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [647.459260] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.919s) [647.641814] [117/133] (378s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [647.742314] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [647.746423] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [647.865950] [118/133] (378s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [647.970521] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [648.971536] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.000s) [649.139553] [119/133] (377s left) gem_ctx_engines (none) [649.214885] Starting subtest: none [649.216958] Subtest none: SUCCESS (0.001s) [649.412058] [120/133] (376s left) gem_pxp (reject-modify-context-protection-on) [649.518698] Starting subtest: reject-modify-context-protection-on [649.521148] Subtest reject-modify-context-protection-on: SUCCESS (0.002s) [649.648596] [121/133] (376s left) kms_cursor_crc (cursor-random-32x10) [649.817560] Starting subtest: cursor-random-32x10 [649.863537] Subtest cursor-random-32x10: SKIP (0.041s) [650.134796] [122/133] (376s left) gem_exec_flush (basic-uc-pro-default) [650.201129] Starting subtest: basic-uc-pro-default [655.658704] Subtest basic-uc-pro-default: SUCCESS (5.457s) [655.872950] [123/133] (370s left) dmabuf_sync_file (import-multiple-read-only) [655.911111] Starting subtest: import-multiple-read-only [655.913371] Subtest import-multiple-read-only: SUCCESS (0.005s) [655.980002] [124/133] (370s left) gem_exec_fence (syncobj-repeat) [656.432581] Starting subtest: syncobj-repeat [656.613447] Subtest syncobj-repeat: SUCCESS (0.179s) [657.789215] [125/133] (368s left) gem_userptr_blits (invalid-null-pointer) [657.869894] Starting subtest: invalid-null-pointer [657.872152] Subtest invalid-null-pointer: SUCCESS (0.001s) [658.038289] [126/133] (368s left) kms_cdclk (plane-scaling) [658.135541] Starting subtest: plane-scaling [658.137671] Starting dynamic subtest: pipe-A-eDP-1 [658.427129] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s) [658.437793] Starting dynamic subtest: pipe-B-eDP-1 [658.442804] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [658.452805] Starting dynamic subtest: pipe-C-eDP-1 [658.457841] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [658.467756] Starting dynamic subtest: pipe-D-eDP-1 [658.472666] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [658.477137] Subtest plane-scaling: SKIP (0.295s) [659.288444] [127/133] (367s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [659.392922] Starting subtest: primary-y-tiled-reflect-x-180 [659.452850] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s) [659.567367] [128/133] (366s left) kms_flip (2x-flip-vs-fences-interruptible) [659.661527] Starting subtest: 2x-flip-vs-fences-interruptible [659.666131] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [659.790740] [129/133] (366s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [659.891194] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [659.895500] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [660.019005] [130/133] (366s left) gem_mmap_gtt (basic-copy) [660.066315] Subtest basic-copy: SKIP (0.000s) [660.121479] [131/133] (366s left) gem_exec_balancer (full-pulse) [660.184100] Starting subtest: full-pulse [664.628319] Subtest full-pulse: SUCCESS (4.444s) [664.927853] [132/133] (361s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [665.028983] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [665.032935] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [665.163742] [133/133] (361s left) gem_wait (busy) [665.224658] Starting subtest: busy [665.227185] Starting dynamic subtest: all-engines [666.739734] Dynamic subtest all-engines: SUCCESS (1.514s) [666.753400] Starting dynamic subtest: rcs0 [667.279796] Dynamic subtest rcs0: SUCCESS (0.539s) [667.292830] Starting dynamic subtest: bcs0 [667.818982] Dynamic subtest bcs0: SUCCESS (0.539s) [667.832056] Starting dynamic subtest: vcs0 [669.748541] Dynamic subtest vcs0: SUCCESS (1.927s) [669.761512] Starting dynamic subtest: vcs1 [671.732341] Dynamic subtest vcs1: SUCCESS (1.982s) [671.745231] Starting dynamic subtest: vecs0 [673.716724] Dynamic subtest vecs0: SUCCESS (1.981s) [673.729620] Starting dynamic subtest: ccs0 [674.259824] Dynamic subtest ccs0: SUCCESS (0.542s) [674.262550] Subtest busy: SUCCESS (9.038s) [674.468343] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: kms_ccs results: parsing output: 2/ for test: kms_chamelium_hpd results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_schedule results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_exec_whisper results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: vgem_basic results: parsing output: 10/ for test: gem_exec_nop results: parsing output: 11/ for test: drm_read results: parsing output: 12/ for test: kms_ccs results: parsing output: 13/ for test: perf_pmu results: parsing output: 14/ for test: kms_flip_scaled_crc results: parsing output: 15/ for test: syncobj_eventfd results: parsing output: 16/ for test: syncobj_wait results: parsing output: 17/ for test: kms_chamelium_edid results: parsing output: 18/ for test: kms_plane results: parsing output: 19/ for test: perf_pmu results: parsing output: 20/ for test: gem_mmap_gtt results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: gem_exec_gttfill results: parsing output: 24/ for test: kms_async_flips results: parsing output: 25/ for test: kms_cursor_legacy results: parsing output: 26/ for test: vgem_basic results: parsing output: 27/ for test: kms_big_fb results: parsing output: 28/ for test: kms_plane_alpha_blend results: parsing output: 29/ for test: gen7_exec_parse results: parsing output: 30/ for test: kms_async_flips results: parsing output: 31/ for test: i915_drm_fdinfo results: parsing output: 32/ for test: syncobj_wait results: parsing output: 33/ for test: syncobj_wait results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: gem_userptr_blits results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: kms_addfb_basic results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_exec_flush results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: i915_pm_rpm results: parsing output: 42/ for test: kms_psr results: parsing output: 43/ for test: kms_force_connector_basic results: parsing output: 44/ for test: gem_mmap_wc results: parsing output: 45/ for test: gem_exec_schedule results: parsing output: 46/ for test: gem_ccs results: parsing output: 47/ for test: prime_mmap results: parsing output: 48/ for test: kms_psr2_sf results: parsing output: 49/ for test: gem_exec_alignment results: parsing output: 50/ for test: gem_fenced_exec_thrash results: parsing output: 51/ for test: kms_pm_dc results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: prime_mmap results: parsing output: 54/ for test: gem_lmem_swapping results: parsing output: 55/ for test: kms_color results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: api_intel_bb results: parsing output: 59/ for test: kms_dither results: parsing output: 60/ for test: kms_vblank results: parsing output: 61/ for test: gem_mmap_offset results: parsing output: 62/ for test: kms_psr2_sf results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: kms_plane_lowres results: parsing output: 65/ for test: kms_flip results: parsing output: 66/ for test: kms_getfb results: parsing output: 67/ for test: gem_pxp results: parsing output: 68/ for test: kms_big_fb results: parsing output: 69/ for test: gem_mmap_gtt results: parsing output: 70/ for test: kms_cursor_crc results: parsing output: 71/ for test: kms_plane_scaling results: parsing output: 72/ for test: kms_rotation_crc results: parsing output: 73/ for test: i915_pm_freq_api results: parsing output: 74/ for test: syncobj_timeline results: parsing output: 75/ for test: gem_ctx_persistence results: parsing output: 76/ for test: gem_exec_create results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: kms_flip_scaled_crc results: parsing output: 79/ for test: syncobj_timeline results: parsing output: 80/ for test: api_intel_allocator results: parsing output: 81/ for test: gem_ctx_persistence results: parsing output: 82/ for test: gem_render_copy results: parsing output: 83/ for test: kms_feature_discovery results: parsing output: 84/ for test: perf results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: perf_pmu results: parsing output: 87/ for test: gen3_render_linear_blits results: parsing output: 88/ for test: gem_eio results: parsing output: 89/ for test: perf results: parsing output: 90/ for test: syncobj_wait results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: kms_big_fb results: parsing output: 94/ for test: kms_rmfb results: parsing output: 95/ for test: syncobj_timeline results: parsing output: 96/ for test: gem_exec_params results: parsing output: 97/ for test: kms_plane_scaling results: parsing output: 98/ for test: kms_pm_rpm results: parsing output: 99/ for test: kms_content_protection results: parsing output: 100/ for test: gem_softpin results: parsing output: 101/ for test: gem_exec_capture results: parsing output: 102/ for test: kms_lease results: parsing output: 103/ for test: gem_tiled_blits results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_psr results: parsing output: 106/ for test: kms_cursor_legacy results: parsing output: 107/ for test: i915_query results: parsing output: 108/ for test: kms_sequence results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_cursor_crc results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_invalid_mode results: parsing output: 113/ for test: kms_ccs results: parsing output: 114/ for test: kms_psr results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_big_fb results: parsing output: 118/ for test: gem_ctx_engines results: parsing output: 119/ for test: gem_pxp results: parsing output: 120/ for test: kms_cursor_crc results: parsing output: 121/ for test: gem_exec_flush results: parsing output: 122/ for test: dmabuf_sync_file results: parsing output: 123/ for test: gem_exec_fence results: parsing output: 124/ for test: gem_userptr_blits results: parsing output: 125/ for test: kms_cdclk results: parsing output: 126/ for test: kms_rotation_crc results: parsing output: 127/ for test: kms_flip results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: gem_mmap_gtt results: parsing output: 130/ for test: gem_exec_balancer results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: gem_wait Done.