[59.955978] Initializing watchdogs
[59.956042]   /dev/watchdog0
[59.970385] [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]
[59.975347] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.977571] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.981103] [001/133] (960s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[60.114639] Starting subtest: fbc-rgb565-draw-mmap-gtt
[60.119774] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[60.212460] [002/133] (960s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[60.379242] Starting subtest: cursor-rapid-movement-32x10
[60.429829] Subtest cursor-rapid-movement-32x10: SKIP (0.049s)
[60.683395] [003/133] (959s left) gem_mmap (bad-object)
[60.736427] Subtest bad-object: SKIP (0.000s)
[60.796830] [004/133] (959s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[60.897828] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[60.902110] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[60.972774] [005/133] (959s left) kms_flip (dpms-off-confusion-interruptible)
[61.069476] Starting subtest: dpms-off-confusion-interruptible
[61.073511] Starting dynamic subtest: A-eDP1
[69.724683] Dynamic subtest A-eDP1: SUCCESS (8.650s)
[69.733861] Starting dynamic subtest: B-eDP1
[78.355868] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[78.365711] Starting dynamic subtest: C-eDP1
[86.978527] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[86.988754] Starting dynamic subtest: D-eDP1
[95.608428] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[95.613185] Subtest dpms-off-confusion-interruptible: SUCCESS (34.538s)
[96.776851] [006/133] (923s left) i915_pm_rps (thresholds-idle)
[96.832868] Starting subtest: thresholds-idle
[96.837193] Subtest thresholds-idle: SKIP (0.000s)
[96.905829] [007/133] (923s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[97.006957] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[97.009293] Starting dynamic subtest: pipe-A-eDP-1
[97.032648] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[97.042229] Starting dynamic subtest: pipe-B-eDP-1
[97.063560] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[97.071083] Starting dynamic subtest: pipe-C-eDP-1
[97.092519] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[97.099787] Starting dynamic subtest: pipe-D-eDP-1
[97.121724] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[97.125783] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[99.159939] [008/133] (921s left) kms_getfb (getfb2-handle-protection)
[99.254898] Starting subtest: getfb2-handle-protection
[99.286959] Subtest getfb2-handle-protection: SUCCESS (0.032s)
[99.389696] [009/133] (921s left) kms_invalid_mode (int-max-clock)
[99.493126] Starting subtest: int-max-clock
[99.495497] Starting dynamic subtest: pipe-A-eDP-1
[99.783488] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[99.792090] Starting dynamic subtest: pipe-B-eDP-1
[99.794268] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[99.801089] Starting dynamic subtest: pipe-C-eDP-1
[99.803321] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[99.810429] Starting dynamic subtest: pipe-D-eDP-1
[99.812341] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[99.814733] Subtest int-max-clock: SUCCESS (0.295s)
[100.583411] [010/133] (920s left) gem_exec_schedule (promotion)
[100.655634] Starting subtest: promotion
[100.657693] Starting dynamic subtest: rcs0
[100.756264] Dynamic subtest rcs0: SUCCESS (0.108s)
[100.763596] Starting dynamic subtest: vcs0
[100.844232] Dynamic subtest vcs0: SUCCESS (0.087s)
[100.853372] Starting dynamic subtest: vcs1
[100.954790] Dynamic subtest vcs1: SUCCESS (0.110s)
[100.965104] Starting dynamic subtest: vecs0
[101.104319] Dynamic subtest vecs0: SUCCESS (0.149s)
[101.115290] Starting dynamic subtest: ccs0
[101.210600] Dynamic subtest ccs0: SUCCESS (0.105s)
[101.213525] Subtest promotion: SUCCESS (0.562s)
[101.999013] [011/133] (918s left) core_getstats (basic)
[102.053818] Starting subtest: basic
[102.056040] Subtest basic: SUCCESS (0.000s)
[102.143430] [012/133] (918s left) gem_exec_fence (syncobj-timeline-chain-engines)
[102.709876] Starting subtest: syncobj-timeline-chain-engines
[102.804745] Subtest syncobj-timeline-chain-engines: SUCCESS (0.096s)
[103.991131] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[103.993934] [013/133] (916s left) kms_psr (psr2-sprite-render)
[104.097382] Starting subtest: psr2-sprite-render
[104.099507] Starting dynamic subtest: eDP-1
[105.786980] Dynamic subtest eDP-1: SUCCESS (1.690s)
[105.789251] Subtest psr2-sprite-render: SUCCESS (1.691s)
[106.648016] [014/133] (914s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[106.763220] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[106.767881] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[106.858219] [015/133] (914s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[106.912876] Starting subtest: framebuffer-vs-set-tiling
[106.917233] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[107.058049] [016/133] (914s left) gem_ctx_engines (invalid-engines)
[107.120383] Starting subtest: invalid-engines
[107.129081] Subtest invalid-engines: SUCCESS (0.008s)
[107.363718] [017/133] (913s left) kms_flip (flip-vs-suspend)
[107.461335] Starting subtest: flip-vs-suspend
[107.463586] Starting dynamic subtest: A-eDP1
[141.054853] Dynamic subtest A-eDP1: SUCCESS (4.327s)
[141.065564] Starting dynamic subtest: B-eDP1
[190.054902] Dynamic subtest B-eDP1: SUCCESS (4.481s)
[190.066900] Starting dynamic subtest: C-eDP1
[239.061864] Dynamic subtest C-eDP1: SUCCESS (4.521s)
[239.072666] Starting dynamic subtest: D-eDP1
[288.069720] Dynamic subtest D-eDP1: SUCCESS (4.496s)
[288.075959] Subtest flip-vs-suspend: SUCCESS (17.834s)
[289.254068] [018/133] (731s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[289.310987] Starting subtest: single-wait-all-for-submit-signaled
[289.313857] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[289.395337] [019/133] (731s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[289.492398] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[289.497733] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[289.586209] [020/133] (731s left) kms_feature_discovery (display-3x)
[289.685785] Starting subtest: display-3x
[289.690826] Subtest display-3x: SKIP (0.000s)
[289.767355] [021/133] (731s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[289.862835] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[296.965916] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.091s)
[297.090225] [022/133] (724s left) dumb_buffer (create-clear)
[297.153451] Starting subtest: create-clear
[330.820109] Subtest create-clear: SUCCESS (33.650s)
[330.914674] [023/133] (690s left) kms_content_protection (atomic)
[331.078816] Starting subtest: atomic
[331.083996] Subtest atomic: SKIP (0.000s)
[331.202570] [024/133] (690s left) gem_readwrite (read-bad-handle)
[331.263444] Subtest read-bad-handle: SKIP (0.000s)
[331.329280] [025/133] (690s left) gem_mmap_wc (close)
[331.390730] Subtest close: SKIP (0.000s)
[331.454129] [026/133] (690s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[331.570691] Starting subtest: modeset-atomic-cursor-hotspot
[331.575943] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[331.713381] [027/133] (689s left) gem_ctx_persistence (many-contexts)
[331.775525] Starting subtest: many-contexts
[369.445666] Subtest many-contexts: SUCCESS (37.662s)
[369.528220] [028/133] (652s left) kms_addfb_basic (basic-y-tiled-legacy)
[369.581727] Starting subtest: basic-y-tiled-legacy
[369.586799] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[369.720598] [029/133] (651s left) kms_psr (psr2-cursor-blt)
[369.819523] Starting subtest: psr2-cursor-blt
[369.821848] Starting dynamic subtest: eDP-1
[371.531599] Dynamic subtest eDP-1: SUCCESS (1.710s)
[371.534457] Subtest psr2-cursor-blt: SUCCESS (1.711s)
[372.397675] [030/133] (649s left) gem_mmap_gtt (basic)
[372.460365] Subtest basic: SKIP (0.000s)
[372.522198] [031/133] (649s left) gem_exec_reloc (basic-write-cpu-noreloc)
[372.585673] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[372.656841] [032/133] (649s left) gem_pxp (create-regular-context-1)
[372.774695] Starting subtest: create-regular-context-1
[372.777838] Subtest create-regular-context-1: SUCCESS (0.001s)
[372.893508] [033/133] (648s left) kms_color (invalid-degamma-lut-sizes)
[372.981796] Starting subtest: invalid-degamma-lut-sizes
[372.984552] Starting dynamic subtest: pipe-A
[373.272542] Dynamic subtest pipe-A: SUCCESS (0.292s)
[373.281485] Starting dynamic subtest: pipe-B
[373.283790] Dynamic subtest pipe-B: SUCCESS (0.000s)
[373.292081] Starting dynamic subtest: pipe-C
[373.294583] Dynamic subtest pipe-C: SUCCESS (0.000s)
[373.302946] Starting dynamic subtest: pipe-D
[373.305847] Dynamic subtest pipe-D: SUCCESS (0.000s)
[373.308676] Subtest invalid-degamma-lut-sizes: SUCCESS (0.295s)
[374.127727] [034/133] (647s left) kms_big_fb (y-tiled-addfb)
[374.234503] Starting subtest: y-tiled-addfb
[374.239829] Subtest y-tiled-addfb: SKIP (0.000s)
[374.335696] [035/133] (647s left) perf_pmu (render-node-busy)
[374.397552] Starting subtest: render-node-busy
[374.399833] Starting dynamic subtest: rcs0
[374.957125] Dynamic subtest rcs0: SUCCESS (0.559s)
[374.968966] Starting dynamic subtest: bcs0
[375.525665] Dynamic subtest bcs0: SUCCESS (0.566s)
[375.538056] Starting dynamic subtest: vcs0
[376.660382] Dynamic subtest vcs0: SUCCESS (1.131s)
[376.672927] Starting dynamic subtest: vcs1
[378.644211] Dynamic subtest vcs1: SUCCESS (1.981s)
[378.656262] Starting dynamic subtest: vecs0
[380.693293] Dynamic subtest vecs0: SUCCESS (2.046s)
[380.706103] Starting dynamic subtest: ccs0
[381.261251] Dynamic subtest ccs0: SUCCESS (0.567s)
[381.264464] Subtest render-node-busy: SUCCESS (6.862s)
[381.355398] [036/133] (640s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[381.454526] Starting subtest: fbcpsr-indfb-scaledprimary
[387.221737] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.771s)
[387.360504] [037/133] (634s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[387.465803] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[394.582916] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.122s)
[394.707485] [038/133] (627s left) gem_mmap_gtt (basic-small-copy-odd)
[394.762840] Subtest basic-small-copy-odd: SKIP (0.000s)
[394.820828] [039/133] (627s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[394.925649] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[395.944357] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.018s)
[396.069222] [040/133] (626s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[396.156972] Starting subtest: random-ccs-data-yf-tiled-ccs
[396.159874] Starting dynamic subtest: pipe-A-eDP-1
[396.188966] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[396.199990] Starting dynamic subtest: pipe-B-eDP-1
[396.227465] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[396.235855] Starting dynamic subtest: pipe-C-eDP-1
[396.261207] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[396.269673] Starting dynamic subtest: pipe-D-eDP-1
[396.294739] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[396.299336] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[398.343158] [041/133] (623s left) kms_addfb_basic (size-max)
[398.436760] Starting subtest: size-max
[398.439465] Subtest size-max: SUCCESS (0.000s)
[398.537643] [042/133] (623s left) kms_pm_dc (dc3co-vpb-simulation)
[399.637337] Starting subtest: dc3co-vpb-simulation
[408.771449] Subtest dc3co-vpb-simulation: SKIP (9.131s)
[408.910697] [043/133] (613s left) gem_softpin (32b-excludes-last-page)
[408.964431] Starting subtest: 32b-excludes-last-page
[408.970381] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[409.081556] [044/133] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[409.181829] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[409.187343] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[409.278028] [045/133] (613s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[409.370594] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[409.375999] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[409.449562] [046/133] (612s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[409.536312] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[409.541838] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[409.610847] [047/133] (612s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[409.702878] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[417.079437] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.379s)
[417.203289] [048/133] (605s left) gem_ctx_exec (basic)
[417.270700] Starting subtest: basic
[417.276924] Subtest basic: SUCCESS (0.005s)
[417.393230] [049/133] (605s left) gem_exec_flush (basic-wb-prw-default)
[417.457470] Starting subtest: basic-wb-prw-default
[422.951409] Subtest basic-wb-prw-default: SUCCESS (5.496s)
[423.143371] [050/133] (599s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[423.243833] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[423.248488] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[423.335754] [051/133] (599s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[423.429873] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[423.432397] Starting dynamic subtest: pipe-A-eDP-1
[423.454459] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[423.473108] Starting dynamic subtest: pipe-B-eDP-1
[423.494803] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[423.503981] Starting dynamic subtest: pipe-C-eDP-1
[423.525943] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[423.539603] Starting dynamic subtest: pipe-D-eDP-1
[423.562693] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[423.565260] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.088s)
[425.850323] [052/133] (596s left) prime_busy (hang-wait)
[425.920757] Starting subtest: hang-wait
[425.923522] Starting dynamic subtest: rcs0
[452.151929] Dynamic subtest rcs0: SUCCESS (26.221s)
[452.163463] Starting dynamic subtest: bcs0
[459.240736] Dynamic subtest bcs0: SUCCESS (7.085s)
[459.249972] Starting dynamic subtest: vcs0
[466.289933] Dynamic subtest vcs0: SUCCESS (7.046s)
[466.300958] Starting dynamic subtest: vcs1
[473.255857] Dynamic subtest vcs1: SUCCESS (6.960s)
[473.269090] Starting dynamic subtest: vecs0
[480.292278] Dynamic subtest vecs0: SUCCESS (7.032s)
[480.311684] Starting dynamic subtest: ccs0
[494.196715] Dynamic subtest ccs0: SUCCESS (13.898s)
[494.199560] Subtest hang-wait: SUCCESS (68.258s)
[494.328241] [053/133] (528s left) gem_exec_reloc (basic-write-read-active)
[494.389594] Subtest basic-write-read-active: SKIP (0.000s)
[494.468822] [054/133] (528s left) api_intel_bb (crc32)
[494.512945] Starting subtest: crc32
[494.515775] Starting dynamic subtest: rcs0-smem0
[494.852914] Dynamic subtest rcs0-smem0: SUCCESS (0.338s)
[494.865524] Starting dynamic subtest: bcs0-smem0
[495.184329] Dynamic subtest bcs0-smem0: SUCCESS (0.328s)
[495.196935] Starting dynamic subtest: vcs0-smem0
[495.566718] Dynamic subtest vcs0-smem0: SUCCESS (0.379s)
[495.579391] Starting dynamic subtest: vcs1-smem0
[495.937238] Dynamic subtest vcs1-smem0: SUCCESS (0.367s)
[495.949945] Starting dynamic subtest: vecs0-smem0
[496.289715] Dynamic subtest vecs0-smem0: SUCCESS (0.350s)
[496.302555] Starting dynamic subtest: ccs0-smem0
[496.651415] Dynamic subtest ccs0-smem0: SUCCESS (0.359s)
[496.654657] Subtest crc32: SUCCESS (2.138s)
[496.774464] [055/133] (526s left) kms_plane_multiple (2x-tiling-x)
[496.867181] Starting subtest: 2x-tiling-x
[496.871952] Subtest 2x-tiling-x: SKIP (0.000s)
[496.941744] [056/133] (525s left) sysfs_heartbeat_interval (precise)
[497.006408] Starting subtest: precise
[497.009064] Starting dynamic subtest: vecs0
[504.657634] Dynamic subtest vecs0: SUCCESS (7.648s)
[504.669884] Starting dynamic subtest: ccs0
[507.590839] Dynamic subtest ccs0: SUCCESS (2.930s)
[507.602131] Starting dynamic subtest: vcs0
[515.663603] Dynamic subtest vcs0: SUCCESS (8.071s)
[515.676424] Starting dynamic subtest: bcs0
[516.726811] Dynamic subtest bcs0: SUCCESS (1.061s)
[516.735990] Starting dynamic subtest: rcs0
[517.767088] Dynamic subtest rcs0: SUCCESS (1.039s)
[517.778075] Starting dynamic subtest: vcs1
[525.652962] Dynamic subtest vcs1: SUCCESS (7.887s)
[525.656050] Subtest precise: SUCCESS (28.648s)
[525.748232] [057/133] (497s left) gem_spin_batch (resubmit-all)
[525.810932] Starting subtest: resubmit-all
[525.813713] Starting dynamic subtest: rcs0
[525.831524] Dynamic subtest rcs0: SUCCESS (0.023s)
[525.841602] Starting dynamic subtest: bcs0
[525.844507] Dynamic subtest bcs0: SUCCESS (0.003s)
[525.853986] Starting dynamic subtest: vcs0
[525.856257] Dynamic subtest vcs0: SUCCESS (0.002s)
[525.864961] Starting dynamic subtest: vcs1
[525.867158] Dynamic subtest vcs1: SUCCESS (0.002s)
[525.875885] Starting dynamic subtest: vecs0
[525.878450] Dynamic subtest vecs0: SUCCESS (0.003s)
[525.888548] Starting dynamic subtest: ccs0
[525.890806] Dynamic subtest ccs0: SUCCESS (0.002s)
[525.893144] Subtest resubmit-all: SUCCESS (0.040s)
[527.691813] [058/133] (495s left) kms_pm_rpm (modeset-non-lpsp-stress)
[529.825239] Starting subtest: modeset-non-lpsp-stress
[530.979258] Subtest modeset-non-lpsp-stress: SKIP (1.155s)
[531.363675] [059/133] (491s left) perf (invalid-open-flags)
[531.504937] Starting subtest: invalid-open-flags
[531.507817] Subtest invalid-open-flags: SUCCESS (0.000s)
[531.556470] [060/133] (491s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[531.648536] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[531.650853] Starting dynamic subtest: pipe-A-eDP-1
[550.541803] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.711s)
[550.552644] Starting dynamic subtest: pipe-B-eDP-1
[568.230883] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.425s)
[568.241102] Starting dynamic subtest: pipe-C-eDP-1
[585.228516] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.431s)
[585.238565] Starting dynamic subtest: pipe-D-eDP-1
[602.198033] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.329s)
[602.200592] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.900s)
[603.349303] [061/133] (419s left) kms_flip (modeset-vs-vblank-race)
[603.447394] Starting subtest: modeset-vs-vblank-race
[603.450081] Starting dynamic subtest: A-eDP1
[608.190803] Dynamic subtest A-eDP1: SUCCESS (4.726s)
[608.203138] Starting dynamic subtest: B-eDP1
[612.925250] Dynamic subtest B-eDP1: SUCCESS (4.723s)
[612.934794] Starting dynamic subtest: C-eDP1
[617.611175] Dynamic subtest C-eDP1: SUCCESS (4.677s)
[617.621623] Starting dynamic subtest: D-eDP1
[622.082307] Dynamic subtest D-eDP1: SUCCESS (4.466s)
[622.088466] Subtest modeset-vs-vblank-race: SUCCESS (18.606s)
[623.245667] [062/133] (399s left) gem_mmap_offset (partial-mmap)
[623.308497] Starting subtest: partial-mmap
[623.310867] Starting dynamic subtest: smem0
[623.313909] Dynamic subtest smem0: SUCCESS (0.005s)
[623.316905] Subtest partial-mmap: SUCCESS (0.006s)
[623.429811] [063/133] (399s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[623.530781] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[623.536511] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[623.629533] [064/133] (399s left) perf_pmu (busy-check-all)
[623.672679] Starting subtest: busy-check-all
[623.674880] Starting dynamic subtest: rcs0
[624.224400] Dynamic subtest rcs0: SUCCESS (0.552s)
[624.239916] Starting dynamic subtest: bcs0
[624.779140] Dynamic subtest bcs0: SUCCESS (0.552s)
[624.791211] Starting dynamic subtest: vcs0
[626.317246] Dynamic subtest vcs0: SUCCESS (1.533s)
[626.329923] Starting dynamic subtest: vcs1
[628.301186] Dynamic subtest vcs1: SUCCESS (1.979s)
[628.313653] Starting dynamic subtest: vecs0
[630.284918] Dynamic subtest vecs0: SUCCESS (1.980s)
[630.297189] Starting dynamic subtest: ccs0
[630.840882] Dynamic subtest ccs0: SUCCESS (0.554s)
[630.843751] Subtest busy-check-all: SUCCESS (7.166s)
[630.959344] [065/133] (392s left) gem_exec_balancer (bonded-sync)
[631.021767] Starting subtest: bonded-sync
[631.027327] Subtest bonded-sync: SKIP (0.000s)
[631.320807] [066/133] (391s left) gem_exec_reloc (basic-gtt-cpu)
[631.373288] Subtest basic-gtt-cpu: SKIP (0.000s)
[631.434720] [067/133] (391s left) gem_ctx_persistence (engines-hostile)
[631.489731] Starting subtest: engines-hostile
[631.492602] Starting dynamic subtest: rcs0
[631.632286] Dynamic subtest rcs0: SUCCESS (0.142s)
[631.643917] Starting dynamic subtest: bcs0
[631.737857] Dynamic subtest bcs0: SUCCESS (0.103s)
[631.750535] Starting dynamic subtest: vcs0
[631.837061] Dynamic subtest vcs0: SUCCESS (0.097s)
[631.848531] Starting dynamic subtest: vcs1
[631.947772] Dynamic subtest vcs1: SUCCESS (0.109s)
[631.959360] Starting dynamic subtest: vecs0
[632.047734] Dynamic subtest vecs0: SUCCESS (0.098s)
[632.059870] Starting dynamic subtest: ccs0
[632.157107] Dynamic subtest ccs0: SUCCESS (0.107s)
[632.159895] Subtest engines-hostile: SUCCESS (0.668s)
[632.239635] [068/133] (391s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[632.333552] Starting subtest: fbc-psr2-sprite-plane-onoff
[632.336142] Starting dynamic subtest: eDP-1
[632.339740] Dynamic subtest eDP-1: SKIP (0.000s)
[632.344277] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[632.412163] [069/133] (390s left) gen9_exec_parse (cmd-crossing-page)
[632.472780] Subtest cmd-crossing-page: SKIP (0.000s)
[632.548471] [070/133] (390s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[632.642688] Starting subtest: pr-cursor-plane-move-continuous-sf
[632.646589] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[632.731083] [071/133] (390s left) sw_sync (alloc_fence_invalid_timeline)
[632.767684] Starting subtest: alloc_fence_invalid_timeline
[632.769859] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[632.826693] [072/133] (390s left) gem_userptr_blits (unsync-unmap)
[632.890683] Subtest unsync-unmap: SKIP (0.000s)
[632.999849] [073/133] (390s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[633.083293] Starting subtest: primary-x-tiled-reflect-x-180
[640.100352] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.022s)
[641.297729] [074/133] (382s left) kms_fbcon_fbt (fbc-suspend)
[641.354752] Starting subtest: fbc-suspend
[691.136070] Subtest fbc-suspend: SUCCESS (18.989s)
[692.446678] [075/133] (331s left) kms_getfb (getfb-handle-zero)
[692.555311] Starting subtest: getfb-handle-zero
[692.558267] Subtest getfb-handle-zero: SUCCESS (0.000s)
[692.653265] [076/133] (331s left) gem_mmap_gtt (cpuset-basic-small-copy)
[692.707528] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[692.762867] [077/133] (330s left) kms_vblank (ts-continuation-suspend)
[692.851414] Starting subtest: ts-continuation-suspend
[692.853905] Starting dynamic subtest: pipe-A-eDP-1
[709.344937] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.535s)
[709.359227] Starting dynamic subtest: pipe-D-eDP-1
[726.316543] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.150s)
[726.318892] Subtest ts-continuation-suspend: SUCCESS (3.689s)
[727.156846] [078/133] (296s left) kms_rmfb (rmfb-ioctl)
[727.262079] Starting subtest: rmfb-ioctl
[727.264336] Starting dynamic subtest: pipe-A-eDP-1
[727.366312] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[727.377460] Starting dynamic subtest: pipe-B-eDP-1
[728.516561] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.144s)
[728.528154] Starting dynamic subtest: pipe-C-eDP-1
[729.653392] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.131s)
[729.663721] Starting dynamic subtest: pipe-D-eDP-1
[730.806528] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.149s)
[730.808619] Subtest rmfb-ioctl: SUCCESS (3.535s)
[732.016469] [079/133] (291s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[732.133755] Starting subtest: psr-rgb101010-draw-mmap-gtt
[732.137659] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[732.232293] [080/133] (291s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[732.322703] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[732.324957] Starting dynamic subtest: pipe-A
[732.660845] Dynamic subtest pipe-A: SUCCESS (0.339s)
[732.670963] Starting dynamic subtest: pipe-B
[734.113332] Dynamic subtest pipe-B: SUCCESS (1.448s)
[734.123335] Starting dynamic subtest: pipe-C
[735.577500] Dynamic subtest pipe-C: SUCCESS (1.460s)
[735.593918] Starting dynamic subtest: pipe-D
[736.989222] Dynamic subtest pipe-D: SUCCESS (1.408s)
[736.991446] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.660s)
[738.150844] [081/133] (285s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[738.253417] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[738.257775] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[738.347928] [082/133] (285s left) i915_pm_freq_api (freq-reset)
[738.413344] Starting subtest: freq-reset
[738.415712] Starting dynamic subtest: gt0
[738.612748] Dynamic subtest gt0: SUCCESS (0.196s)
[738.622525] Starting dynamic subtest: gt1
[738.781064] Dynamic subtest gt1: SUCCESS (0.168s)
[738.783673] Subtest freq-reset: SUCCESS (0.367s)
[738.857422] [083/133] (285s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[738.919010] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[738.921183] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[739.009648] [084/133] (285s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[739.108894] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[739.113349] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[739.202980] [085/133] (284s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[739.321388] Starting subtest: cursor-vs-flip-legacy
[768.660517] Subtest cursor-vs-flip-legacy: SUCCESS (29.327s)
[769.518262] [086/133] (254s left) gem_mmap_wc (write-read)
[769.592113] Subtest write-read: SKIP (0.000s)
[769.659830] [087/133] (254s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[769.755029] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[769.756886] Starting dynamic subtest: pipe-A-eDP-1
[769.777446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[769.791303] Starting dynamic subtest: pipe-B-eDP-1
[769.811472] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[769.822666] Starting dynamic subtest: pipe-C-eDP-1
[769.842673] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[769.853094] Starting dynamic subtest: pipe-D-eDP-1
[769.872277] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s)
[769.874375] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.098s)
[772.177831] [088/133] (252s left) kms_lease (master-vs-lease)
[772.274844] Starting subtest: master-vs-lease
[772.277085] Subtest master-vs-lease: SUCCESS (0.002s)
[772.385258] [089/133] (251s left) kms_psr (psr-primary-blt)
[772.489204] Starting subtest: psr-primary-blt
[772.491474] Starting dynamic subtest: eDP-1
[774.184304] Dynamic subtest eDP-1: SUCCESS (1.695s)
[774.186716] Subtest psr-primary-blt: SUCCESS (1.697s)
[775.059376] [090/133] (249s left) kms_force_connector_basic (prune-stale-modes)
[775.143062] Starting subtest: prune-stale-modes
[775.579557] Subtest prune-stale-modes: SUCCESS (0.439s)
[775.731343] [091/133] (248s left) gem_mmap_gtt (medium-copy)
[775.791835] Subtest medium-copy: SKIP (0.000s)
[775.859445] [092/133] (248s left) kms_vblank (crtc-id)
[775.957201] Starting subtest: crtc-id
[775.959460] Starting dynamic subtest: pipe-A-eDP-1
[776.398445] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[776.415572] Starting dynamic subtest: pipe-D-eDP-1
[777.582930] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.180s)
[777.585206] Subtest crtc-id: SUCCESS (1.626s)
[778.388387] [093/133] (246s left) kms_cursor_crc (cursor-offscreen-64x64)
[778.580045] Starting subtest: cursor-offscreen-64x64
[778.585037] Starting dynamic subtest: pipe-A-eDP-1
[780.551225] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.965s)
[780.582911] Starting dynamic subtest: pipe-D-eDP-1
[783.159325] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.587s)
[783.161695] Subtest cursor-offscreen-64x64: SUCCESS (4.579s)
[783.984174] [094/133] (240s left) gem_exec_schedule (preempt-other)
[784.056458] Starting subtest: preempt-other
[784.058782] Starting dynamic subtest: rcs0
[784.122419] Dynamic subtest rcs0: SUCCESS (0.074s)
[784.135767] Starting dynamic subtest: bcs0
[784.189946] Dynamic subtest bcs0: SUCCESS (0.067s)
[784.205433] Starting dynamic subtest: vcs0
[784.266445] Dynamic subtest vcs0: SUCCESS (0.075s)
[784.278493] Starting dynamic subtest: vcs1
[784.334769] Dynamic subtest vcs1: SUCCESS (0.069s)
[784.348870] Starting dynamic subtest: vecs0
[784.407261] Dynamic subtest vecs0: SUCCESS (0.072s)
[784.423756] Starting dynamic subtest: ccs0
[784.473609] Dynamic subtest ccs0: SUCCESS (0.065s)
[784.476023] Subtest preempt-other: SUCCESS (0.426s)
[785.933784] [095/133] (238s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[786.328834] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[787.149842] [096/133] (237s left) syncobj_timeline (invalid-query-bad-pad)
[787.200361] Starting subtest: invalid-query-bad-pad
[787.202353] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[787.315465] [097/133] (237s left) kms_plane_alpha_blend (alpha-7efc)
[787.406355] Starting subtest: alpha-7efc
[787.698560] Starting dynamic subtest: pipe-A-eDP-1
[788.299394] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[788.330720] Starting dynamic subtest: pipe-D-eDP-1
[789.650094] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[789.652423] Subtest alpha-7efc: SUCCESS (2.245s)
[790.480255] [098/133] (234s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[790.613512] Starting subtest: cursorA-vs-flipB-atomic
[790.618098] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[790.761768] [099/133] (233s left) gem_blits (basic)
[790.827700] Starting subtest: basic
[792.272513] Subtest basic: SUCCESS (1.444s)
[792.410991] [100/133] (232s left) syncobj_timeline (multi-wait-submitted-signaled)
[792.458728] Starting subtest: multi-wait-submitted-signaled
[792.460646] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[792.556038] [101/133] (232s left) gem_workarounds (reset)
[792.623904] Starting subtest: reset
[792.810159] Subtest reset: SUCCESS (0.187s)
[792.961706] [102/133] (231s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[793.070764] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[794.117011] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.046s)
[794.239620] [103/133] (230s left) kms_big_fb (linear-64bpp-rotate-270)
[794.346421] Starting subtest: linear-64bpp-rotate-270
[794.366442] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[794.496044] [104/133] (230s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[794.585390] Starting subtest: blocking-absolute-wf_vblank-interruptible
[794.587029] Starting dynamic subtest: A-eDP1
[803.305551] Dynamic subtest A-eDP1: SUCCESS (8.715s)
[803.317228] Starting dynamic subtest: B-eDP1
[812.008985] Dynamic subtest B-eDP1: SUCCESS (8.699s)
[812.021623] Starting dynamic subtest: C-eDP1
[820.685163] Dynamic subtest C-eDP1: SUCCESS (8.670s)
[820.696943] Starting dynamic subtest: D-eDP1
[829.396706] Dynamic subtest D-eDP1: SUCCESS (8.711s)
[829.402927] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.809s)
[830.580854] [105/133] (194s left) gen9_exec_parse (valid-registers)
[830.644603] Subtest valid-registers: SKIP (0.000s)
[830.716480] [106/133] (194s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[830.814934] Starting subtest: fbc-psr2-cursor-plane-onoff
[830.817108] Starting dynamic subtest: eDP-1
[830.821074] Dynamic subtest eDP-1: SKIP (0.000s)
[830.825043] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[830.891040] [107/133] (194s left) prime_mmap (test_reprime)
[830.954627] Starting subtest: test_reprime
[830.956911] Starting dynamic subtest: test_reprime-smem
[830.985511] Dynamic subtest test_reprime-smem: SUCCESS (0.033s)
[830.987927] Subtest test_reprime: SUCCESS (0.034s)
[831.112749] [108/133] (193s left) gem_exec_flush (basic-wb-rw-default)
[831.176414] Starting subtest: basic-wb-rw-default
[836.645212] Subtest basic-wb-rw-default: SUCCESS (5.471s)
[836.843911] [109/133] (188s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[836.954290] Starting subtest: plane-all-modeset-transition-fencing
[836.958371] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[837.029399] [110/133] (188s left) kms_selftest (drm_damage_helper)
[837.067826] Starting subtest: drm_damage_helper
[837.119089] Starting dynamic subtest: drm_test_damage_iter_no_damage
[837.233721] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.115s)
[837.243433] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[837.329488] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.095s)
[837.340748] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[837.438370] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.107s)
[837.449749] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[837.538882] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.100s)
[837.549897] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[837.651386] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.112s)
[837.660530] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[837.768419] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.116s)
[837.777662] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[837.864482] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.095s)
[837.875434] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[837.984008] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.119s)
[837.993578] Starting dynamic subtest: drm_test_damage_iter_single_damage
[838.087169] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.101s)
[838.098288] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[838.193003] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.105s)
[838.203915] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[838.285185] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.092s)
[838.295559] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[838.373875] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.088s)
[838.384409] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[838.484033] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.109s)
[838.494497] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[838.579458] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.096s)
[838.589150] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[838.670359] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.090s)
[838.679947] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[838.767981] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.094s)
[838.778491] Starting dynamic subtest: drm_test_damage_iter_damage
[838.871858] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.105s)
[838.881037] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[838.974319] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.101s)
[838.984819] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[839.078881] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.104s)
[839.087658] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[839.198388] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.118s)
[839.208208] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[839.305283] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.105s)
[839.307683] Subtest drm_damage_helper: SUCCESS (2.238s)
[839.478126] [111/133] (185s left) kms_cursor_crc (cursor-sliding-64x21)
[839.700657] Starting subtest: cursor-sliding-64x21
[839.749881] Subtest cursor-sliding-64x21: SKIP (0.045s)
[839.989499] [112/133] (185s left) kms_atomic_transition (modeset-transition)
[840.083084] Starting subtest: modeset-transition
[840.085286] Starting dynamic subtest: 1x-outputs
[850.938751] Dynamic subtest 1x-outputs: SUCCESS (10.857s)
[850.941368] Subtest modeset-transition: SUCCESS (10.859s)
[851.773480] [113/133] (173s left) gem_exec_whisper (basic-queues)
[851.838829] Starting subtest: basic-queues
[859.802027] Subtest basic-queues: SUCCESS (7.961s)
[859.984539] [114/133] (165s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[860.090681] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[860.094956] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[860.165439] [115/133] (165s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[860.269007] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[860.271158] Starting dynamic subtest: pipe-A
[860.331106] Dynamic subtest pipe-A: SUCCESS (0.064s)
[860.342945] Starting dynamic subtest: pipe-B
[861.460670] Dynamic subtest pipe-B: SUCCESS (1.128s)
[861.470901] Starting dynamic subtest: pipe-C
[862.561926] Dynamic subtest pipe-C: SUCCESS (1.100s)
[862.572647] Starting dynamic subtest: pipe-D
[863.653068] Dynamic subtest pipe-D: SUCCESS (1.090s)
[863.655426] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.386s)
[864.765990] [116/133] (160s left) gem_exec_gttfill (engines)
[864.820843] Starting subtest: engines
[864.823276] Starting dynamic subtest: rcs0
[887.866537] Dynamic subtest rcs0: SUCCESS (23.041s)
[887.878070] Starting dynamic subtest: bcs0
[911.215624] Dynamic subtest bcs0: SUCCESS (23.342s)
[911.230479] Starting dynamic subtest: vcs0
[934.535034] Dynamic subtest vcs0: SUCCESS (23.311s)
[934.547994] Starting dynamic subtest: vcs1
[957.865299] Dynamic subtest vcs1: SUCCESS (23.323s)
[957.876051] Starting dynamic subtest: vecs0
[981.211170] Dynamic subtest vecs0: SUCCESS (23.349s)
[981.221179] Starting dynamic subtest: ccs0
[1004.560051] Dynamic subtest ccs0: SUCCESS (23.347s)
[1004.562782] Subtest engines: SUCCESS (139.727s)
[1004.751929] [117/133] ( 20s left) syncobj_eventfd (invalid-illegal-eventfd)
[1004.862994] Starting subtest: invalid-illegal-eventfd
[1004.864950] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[1004.957078] [118/133] ( 20s left) gem_eio (create)
[1005.206800] Starting subtest: create
[1005.558518] Subtest create: SUCCESS (0.350s)
[1005.701027] [119/133] ( 19s left) gem_render_copy_redux (interruptible)
[1005.769468] Starting subtest: interruptible
[1006.178530] Subtest interruptible: SUCCESS (0.409s)
[1006.273427] [120/133] ( 19s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[1006.380648] Starting subtest: protected-encrypted-src-copy-not-readible
[1006.513171] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.132s)
[1006.635380] [121/133] ( 18s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[1006.734266] Starting subtest: x-tiled-64bpp-rotate-0
[1008.436574] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.703s)
[1008.606277] [122/133] ( 17s left) gem_lmem_swapping (heavy-random)
[1008.651061] Subtest heavy-random: SKIP (0.000s)
[1008.704138] [123/133] ( 17s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[1008.804043] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[1008.807378] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[1008.904469] [124/133] ( 16s left) perf (rc6-disable)
[1009.020496] Starting subtest: rc6-disable
[1009.219016] Subtest rc6-disable: SUCCESS (0.198s)
[1009.283803] [125/133] ( 16s left) gem_userptr_blits (vma-merge)
[1009.365426] Starting subtest: vma-merge
[1009.407432] Subtest vma-merge: SUCCESS (0.045s)
[1009.532186] [126/133] ( 16s left) gem_exec_big (single)
[1009.585701] Starting subtest: single
[1011.813193] Subtest single: SUCCESS (2.225s)
[1012.021617] [127/133] ( 13s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[1012.172232] Starting subtest: pipe-fbc-rte
[1012.178795] Starting dynamic subtest: pipe-B-eDP-1
[1017.569573] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.402s)
[1017.577356] Subtest pipe-fbc-rte: SUCCESS (5.404s)
[1019.863654] [128/133] (  6s left) i915_pm_rps (min-max-config-loaded)
[1019.918806] Starting subtest: min-max-config-loaded
[1019.922943] Subtest min-max-config-loaded: SKIP (0.000s)
[1020.043227] [129/133] (  5s left) kms_psr (fbc-pr-no-drrs)
[1020.151960] Starting subtest: fbc-pr-no-drrs
[1020.156136] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[1020.227795] [130/133] (  5s left) kms_chamelium_frames (hdmi-frame-dump)
[1020.604579] Subtest hdmi-frame-dump: SKIP (0.000s)
[1021.453728] [131/133] (  4s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[1021.558763] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[1028.262125] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.706s)
[1028.384402] Overall timeout time exceeded, stopping.
[1028.402472] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: gem_mmap
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: i915_pm_rps
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_getfb
results: parsing output: 8/ for test: kms_invalid_mode
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: core_getstats
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: gem_ctx_engines
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_feature_discovery
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: dumb_buffer
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: gem_readwrite
results: parsing output: 24/ for test: gem_mmap_wc
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_color
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_addfb_basic
results: parsing output: 41/ for test: kms_pm_dc
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_ctx_exec
results: parsing output: 48/ for test: gem_exec_flush
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: prime_busy
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: api_intel_bb
results: parsing output: 54/ for test: kms_plane_multiple
results: parsing output: 55/ for test: sysfs_heartbeat_interval
results: parsing output: 56/ for test: gem_spin_batch
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: gem_mmap_offset
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gen9_exec_parse
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: sw_sync
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: kms_rotation_crc
results: parsing output: 73/ for test: kms_fbcon_fbt
results: parsing output: 74/ for test: kms_getfb
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: kms_rmfb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: i915_pm_freq_api
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: gem_mmap_wc
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_lease
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_force_connector_basic
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: kms_vblank
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_plane_alpha_blend
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_blits
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: gem_workarounds
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gen9_exec_parse
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: prime_mmap
results: parsing output: 107/ for test: gem_exec_flush
results: parsing output: 108/ for test: kms_atomic_transition
results: parsing output: 109/ for test: kms_selftest
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_atomic_transition
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_plane_scaling
results: parsing output: 115/ for test: gem_exec_gttfill
results: parsing output: 116/ for test: syncobj_eventfd
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: gem_render_copy_redux
results: parsing output: 119/ for test: gem_pxp
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_lmem_swapping
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: gem_exec_big
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: i915_pm_rps
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_chamelium_frames
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 132/ for test: gem_exec_create
results: no output, setting notrun
Done.