[60.235022] Initializing watchdogs
[60.235094]   /dev/watchdog0
[60.249156] [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.253303] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.255704] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.258943] [001/132] (960s left) gem_spin_batch (engines)
[60.347958] Starting subtest: engines
[60.350370] Starting dynamic subtest: rcs0
[63.644998] Dynamic subtest rcs0: SUCCESS (3.240s)
[63.654358] Starting dynamic subtest: bcs0
[66.828675] Dynamic subtest bcs0: SUCCESS (3.235s)
[66.837850] Starting dynamic subtest: vcs0
[70.107300] Dynamic subtest vcs0: SUCCESS (3.227s)
[70.117880] Starting dynamic subtest: vcs1
[73.344286] Dynamic subtest vcs1: SUCCESS (3.237s)
[73.353504] Starting dynamic subtest: vecs0
[76.580981] Dynamic subtest vecs0: SUCCESS (3.235s)
[76.590170] Starting dynamic subtest: ccs0
[79.819570] Dynamic subtest ccs0: SUCCESS (3.237s)
[79.822426] Subtest engines: SUCCESS (19.417s)
[80.001193] [002/132] (940s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[80.132069] Starting subtest: fbc-rgb101010-draw-blt
[84.744745] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.614s)
[85.946012] [003/132] (934s left) kms_content_protection (type1)
[86.102425] Starting subtest: type1
[86.107135] Subtest type1: SKIP (0.000s)
[86.245189] [004/132] (934s left) gem_partial_pwrite_pread (reads-snoop)
[86.313139] Subtest reads-snoop: SKIP (0.000s)
[86.374065] [005/132] (934s left) kms_psr (fbc-pr-primary-page-flip)
[86.456641] Starting subtest: fbc-pr-primary-page-flip
[86.461179] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[86.525573] [006/132] (934s left) gem_huc_copy (huc-copy)
[86.590845] Starting subtest: huc-copy
[86.593198] Subtest huc-copy: SUCCESS (0.003s)
[86.712502] [007/132] (934s left) gem_exec_fence (syncobj-repeat)
[87.149079] Starting subtest: syncobj-repeat
[87.331308] Subtest syncobj-repeat: SUCCESS (0.181s)
[88.981872] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[88.985098] [008/132] (932s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[89.110131] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[89.114452] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[89.196963] [009/132] (931s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[89.285898] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[89.290504] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[90.376932] [010/132] (930s left) sysfs_heartbeat_interval (idempotent)
[90.429626] Starting subtest: idempotent
[90.431917] Starting dynamic subtest: vecs0
[90.434253] Dynamic subtest vecs0: SUCCESS (0.001s)
[90.441097] Starting dynamic subtest: ccs0
[90.443043] Dynamic subtest ccs0: SUCCESS (0.001s)
[90.449803] Starting dynamic subtest: vcs0
[90.452070] Dynamic subtest vcs0: SUCCESS (0.000s)
[90.458725] Starting dynamic subtest: bcs0
[90.460928] Dynamic subtest bcs0: SUCCESS (0.000s)
[90.468078] Starting dynamic subtest: rcs0
[90.469963] Dynamic subtest rcs0: SUCCESS (0.001s)
[90.476298] Starting dynamic subtest: vcs1
[90.478629] Dynamic subtest vcs1: SUCCESS (0.000s)
[90.480839] Subtest idempotent: SUCCESS (0.005s)
[90.522538] [011/132] (930s left) gen3_render_tiledy_blits
[90.642739] [012/132] (930s left) gem_exec_schedule (u-fairslice-all)
[90.720294] Starting subtest: u-fairslice-all
[92.822405] Subtest u-fairslice-all: SUCCESS (2.064s)
[93.937375] [013/132] (927s left) gem_exec_reloc (basic-scanout)
[93.995035] Subtest basic-scanout: SKIP (0.000s)
[94.070676] [014/132] (927s left) gem_userptr_blits (process-exit-busy)
[94.141010] Starting subtest: process-exit-busy
[94.161909] Subtest process-exit-busy: SUCCESS (0.023s)
[94.313058] [015/132] (926s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[94.414018] Starting subtest: fbcpsr-suspend
[134.640211] Subtest fbcpsr-suspend: SUCCESS (11.101s)
[134.808333] [016/132] (886s left) kms_cursor_crc (cursor-sliding-64x64)
[135.000201] Starting subtest: cursor-sliding-64x64
[135.002973] Starting dynamic subtest: pipe-A-eDP-1
[138.271946] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.266s)
[138.303794] Starting dynamic subtest: pipe-D-eDP-1
[142.143826] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.842s)
[142.146256] Subtest cursor-sliding-64x64: SUCCESS (7.136s)
[143.015521] [017/132] (878s left) syncobj_wait (wait-all-for-submit-snapshot)
[143.070710] Starting subtest: wait-all-for-submit-snapshot
[143.153292] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[143.227589] [018/132] (878s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[143.336995] Starting subtest: yf-tiled-64bpp-rotate-180
[143.341068] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[143.435383] [019/132] (878s left) kms_chamelium_color (ctm-0-50)
[143.530568] Subtest ctm-0-50: SKIP (0.000s)
[143.575864] [020/132] (877s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[143.677394] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[143.681658] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[143.779614] [021/132] (877s left) gem_userptr_blits (nohangcheck)
[143.853269] Starting subtest: nohangcheck
[144.100282] Subtest nohangcheck: SUCCESS (0.246s)
[144.225532] [022/132] (877s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[144.324131] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[144.328659] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[144.421998] [023/132] (877s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[144.526152] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[144.530472] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[144.626556] [024/132] (877s left) prime_vgem (fence-flip-hang)
[144.709719] Subtest fence-flip-hang: SKIP (0.000s)
[144.807188] [025/132] (876s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[144.900813] Starting subtest: bo-too-small-due-to-tiling
[144.905478] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[144.995967] [026/132] (876s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[145.087837] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[145.091209] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[145.195829] [027/132] (876s left) kms_force_connector_basic (force-edid)
[145.267991] Starting subtest: force-edid
[145.634809] Subtest force-edid: SUCCESS (0.366s)
[145.778095] [028/132] (876s left) syncobj_timeline (wait-all-snapshot)
[145.831439] Starting subtest: wait-all-snapshot
[145.914450] Subtest wait-all-snapshot: SUCCESS (0.083s)
[145.987278] [029/132] (875s left) kms_psr (psr2-cursor-mmap-cpu)
[146.082527] Starting subtest: psr2-cursor-mmap-cpu
[146.084484] Starting dynamic subtest: eDP-1
[147.788784] Dynamic subtest eDP-1: SUCCESS (1.704s)
[147.791446] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.705s)
[148.676281] [030/132] (873s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[148.731228] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[148.735900] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[148.911500] [031/132] (873s left) gem_userptr_blits (create-destroy-unsync)
[148.995577] Subtest create-destroy-unsync: SKIP (0.000s)
[149.134337] [032/132] (872s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[149.189684] Subtest tiled-to-untiled: SKIP (0.000s)
[149.260486] [033/132] (872s left) kms_vblank (ts-continuation-modeset)
[149.349495] Starting subtest: ts-continuation-modeset
[149.351796] Starting dynamic subtest: pipe-A-eDP-1
[150.829834] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.477s)
[150.845997] Starting dynamic subtest: pipe-D-eDP-1
[153.002308] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.170s)
[153.004664] Subtest ts-continuation-modeset: SUCCESS (3.651s)
[153.797050] [034/132] (868s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[153.870012] Starting subtest: invalid-bsd1-flag-on-blt
[153.872453] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[153.973488] [035/132] (868s left) kms_color (ctm-blue-to-red)
[154.060547] Starting subtest: ctm-blue-to-red
[154.062532] Starting dynamic subtest: pipe-A-eDP-1
[154.738062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.680s)
[154.749082] Starting dynamic subtest: pipe-B-eDP-1
[156.099885] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.358s)
[156.111070] Starting dynamic subtest: pipe-C-eDP-1
[157.509054] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.408s)
[157.518252] Starting dynamic subtest: pipe-D-eDP-1
[158.793942] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.285s)
[158.796247] Subtest ctm-blue-to-red: SUCCESS (4.733s)
[159.634423] [036/132] (862s left) syncobj_wait (invalid-reset-zero-handles)
[159.686589] Starting subtest: invalid-reset-zero-handles
[159.688680] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[159.789452] [037/132] (862s left) i915_query (query-topology-known-pci-ids)
[159.843364] Starting subtest: query-topology-known-pci-ids
[159.847510] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[159.953806] [038/132] (862s left) kms_sequence (queue-idle)
[160.062011] Starting subtest: queue-idle
[160.064013] Starting dynamic subtest: pipe-A-eDP-1
[161.866351] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.803s)
[161.875619] Starting dynamic subtest: pipe-B-eDP-1
[164.307447] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.441s)
[164.316829] Starting dynamic subtest: pipe-C-eDP-1
[166.739451] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.432s)
[166.748165] Starting dynamic subtest: pipe-D-eDP-1
[169.172071] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.430s)
[169.174128] Subtest queue-idle: SUCCESS (9.110s)
[169.984549] [039/132] (852s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[170.110496] Starting subtest: verify-pxp-key-change-after-suspend-resume
[177.288616] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.182s)
[177.400276] [040/132] (844s left) i915_drm_fdinfo (virtual-busy-idle-all)
[177.444724] Starting subtest: virtual-busy-idle-all
[177.448889] Subtest virtual-busy-idle-all: SKIP (0.000s)
[177.512380] [041/132] (844s left) kms_chamelium_hpd (dp-hpd)
[177.891655] Subtest dp-hpd: SKIP (0.000s)
[178.672989] [042/132] (843s left) sw_sync (timeline_closed_signaled)
[178.720123] Starting subtest: timeline_closed_signaled
[178.722068] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[178.773693] [043/132] (843s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[178.867363] Starting subtest: compare-crc-sanitycheck-nv12
[178.869230] Starting dynamic subtest: pipe-A-eDP-1
[179.560782] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.693s)
[179.570232] Starting dynamic subtest: pipe-B-eDP-1
[180.908880] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.349s)
[180.918508] Starting dynamic subtest: pipe-C-eDP-1
[182.139364] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.227s)
[182.149047] Starting dynamic subtest: pipe-D-eDP-1
[183.369114] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[183.371478] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.502s)
[184.228044] [044/132] (838s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[184.312749] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[184.315009] Starting dynamic subtest: pipe-A
[184.648736] Dynamic subtest pipe-A: SUCCESS (0.337s)
[184.659006] Starting dynamic subtest: pipe-B
[186.008046] Dynamic subtest pipe-B: SUCCESS (1.359s)
[186.017327] Starting dynamic subtest: pipe-C
[187.441314] Dynamic subtest pipe-C: SUCCESS (1.432s)
[187.450827] Starting dynamic subtest: pipe-D
[188.878064] Dynamic subtest pipe-D: SUCCESS (1.436s)
[188.880459] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.567s)
[190.084847] [045/132] (832s left) kms_chamelium_color (gamma)
[190.184065] Subtest gamma: SKIP (0.000s)
[190.227871] [046/132] (832s left) kms_getfb (getfb2-handle-zero)
[190.315341] Starting subtest: getfb2-handle-zero
[190.317558] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[190.427777] [047/132] (832s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[190.532793] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[190.536989] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[190.619170] [048/132] (832s left) kms_properties (connector-properties-legacy)
[190.716595] Starting subtest: connector-properties-legacy
[190.718911] Starting dynamic subtest: pipe-A-eDP-1
[198.651697] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.935s)
[198.661037] Starting dynamic subtest: pipe-None-DP-1
[198.665784] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[198.673309] Starting dynamic subtest: pipe-None-HDMI-A-1
[198.677647] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[198.685287] Starting dynamic subtest: pipe-None-DP-2
[198.689377] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[198.696845] Starting dynamic subtest: pipe-None-HDMI-A-2
[198.700944] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[198.708360] Starting dynamic subtest: pipe-None-DP-3
[198.712481] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[198.720711] Starting dynamic subtest: pipe-None-DP-4
[198.725613] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[198.727879] Subtest connector-properties-legacy: SUCCESS (7.945s)
[199.518715] [049/132] (823s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[199.618078] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[199.620395] Starting dynamic subtest: pipe-A-default-mode
[202.342535] Dynamic subtest pipe-A-default-mode: SUCCESS (2.723s)
[202.344501] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.724s)
[203.223731] [050/132] (819s left) gem_exec_reloc (basic-gtt-read-noreloc)
[203.284348] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[203.348293] [051/132] (819s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[203.439804] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[203.466050] Starting dynamic subtest: pipe-A-plane-0
[203.754676] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[203.762607] Starting dynamic subtest: pipe-A-plane-3
[203.988143] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[203.996470] Starting dynamic subtest: pipe-A-plane-5
[204.000637] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[205.088693] Starting dynamic subtest: pipe-B-plane-0
[205.382266] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[205.390702] Starting dynamic subtest: pipe-B-plane-3
[205.615756] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[205.624807] Starting dynamic subtest: pipe-B-plane-5
[205.628911] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[205.925887] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.484s)
[206.759964] [052/132] (816s left) kms_psr (fbc-pr-primary-blt)
[206.854155] Starting subtest: fbc-pr-primary-blt
[206.858375] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[206.926981] [053/132] (815s left) kms_big_fb (x-tiled-addfb)
[207.025219] Starting subtest: x-tiled-addfb
[207.027519] Subtest x-tiled-addfb: SUCCESS (0.000s)
[207.114308] [054/132] (815s left) perf_pmu (busy)
[207.158193] Starting subtest: busy
[207.160454] Starting dynamic subtest: rcs0
[207.753342] Dynamic subtest rcs0: SUCCESS (0.595s)
[207.763501] Starting dynamic subtest: bcs0
[208.320258] Dynamic subtest bcs0: SUCCESS (0.564s)
[208.329914] Starting dynamic subtest: vcs0
[210.010400] Dynamic subtest vcs0: SUCCESS (1.686s)
[210.020164] Starting dynamic subtest: vcs1
[211.993992] Dynamic subtest vcs1: SUCCESS (1.980s)
[212.005927] Starting dynamic subtest: vecs0
[214.041680] Dynamic subtest vecs0: SUCCESS (2.045s)
[214.053444] Starting dynamic subtest: ccs0
[214.610774] Dynamic subtest ccs0: SUCCESS (0.567s)
[214.613552] Subtest busy: SUCCESS (7.453s)
[214.704205] [055/132] (808s left) gem_pwrite (basic-exhaustion)
[214.765563] Subtest basic-exhaustion: SKIP (0.000s)
[214.826080] [056/132] (808s left) syncobj_timeline (invalid-signal-illegal-point)
[214.897254] Starting subtest: invalid-signal-illegal-point
[214.899169] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[215.011585] [057/132] (808s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[215.112874] Starting subtest: psr-rgb101010-draw-pwrite
[222.584225] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.474s)
[222.695735] [058/132] (800s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[222.785799] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[229.557512] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.775s)
[229.706273] [059/132] (793s left) api_intel_bb (delta-check)
[229.763949] Starting subtest: delta-check
[229.769253] Subtest delta-check: SUCCESS (0.005s)
[229.893643] [060/132] (793s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[229.995448] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[229.997698] Starting dynamic subtest: pipe-A-eDP-1
[230.019495] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.029376] Starting dynamic subtest: pipe-B-eDP-1
[230.049360] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[230.057109] Starting dynamic subtest: pipe-C-eDP-1
[230.077492] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[230.085556] Starting dynamic subtest: pipe-D-eDP-1
[230.106731] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[230.110992] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[232.176116] [061/132] (791s left) api_intel_allocator (two-level-inception)
[232.225756] Starting subtest: two-level-inception
[237.676707] Subtest two-level-inception: SUCCESS (5.400s)
[237.753595] [062/132] (785s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[237.853618] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[237.855875] Starting dynamic subtest: pipe-A-default-mode
[239.038182] Dynamic subtest pipe-A-default-mode: SKIP (1.182s)
[239.042819] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.184s)
[239.209195] [063/132] (784s left) gem_ctx_param (invalid-get-engines)
[239.264775] Starting subtest: invalid-get-engines
[239.267005] Subtest invalid-get-engines: SUCCESS (0.001s)
[239.411276] [064/132] (783s left) kms_cursor_crc (cursor-random-128x128)
[239.629948] Starting subtest: cursor-random-128x128
[239.634857] Starting dynamic subtest: pipe-A-eDP-1
[243.002053] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.365s)
[243.030482] Starting dynamic subtest: pipe-D-eDP-1
[246.996542] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.971s)
[246.998745] Subtest cursor-random-128x128: SUCCESS (7.363s)
[247.887253] [065/132] (775s left) gem_ctx_shared (exec-shared-gtt)
[247.951953] Starting subtest: exec-shared-gtt
[247.954176] Starting dynamic subtest: rcs0
[247.960364] Dynamic subtest rcs0: SUCCESS (0.008s)
[247.970961] Starting dynamic subtest: bcs0
[247.973130] Dynamic subtest bcs0: SUCCESS (0.006s)
[247.982070] Starting dynamic subtest: vcs0
[247.984381] Dynamic subtest vcs0: SUCCESS (0.007s)
[247.993018] Starting dynamic subtest: vcs1
[247.994863] Dynamic subtest vcs1: SUCCESS (0.006s)
[248.003227] Starting dynamic subtest: vecs0
[248.005453] Dynamic subtest vecs0: SUCCESS (0.006s)
[248.013504] Starting dynamic subtest: ccs0
[248.015682] Dynamic subtest ccs0: SUCCESS (0.005s)
[248.017904] Subtest exec-shared-gtt: SUCCESS (0.044s)
[248.188801] [066/132] (775s left) kms_pm_lpsp (screens-disabled)
[249.290724] Starting subtest: screens-disabled
[249.295110] Subtest screens-disabled: SKIP (0.000s)
[249.362703] [067/132] (774s left) kms_plane_lowres (tiling-y)
[249.461544] Starting subtest: tiling-y
[249.465635] Subtest tiling-y: SKIP (0.000s)
[249.543895] [068/132] (773s left) kms_dsc (dsc-with-bpc)
[249.650071] Starting subtest: dsc-with-bpc
[249.679718] Subtest dsc-with-bpc: SKIP (0.001s)
[249.737846] [069/132] (773s left) kms_psr (fbc-psr-no-drrs)
[249.840132] Starting subtest: fbc-psr-no-drrs
[249.842284] Starting dynamic subtest: eDP-1
[249.846183] Dynamic subtest eDP-1: SKIP (0.000s)
[249.850178] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[249.932268] [070/132] (773s left) gem_eio (wait-1us)
[250.334395] Starting subtest: wait-1us
[250.698598] Subtest wait-1us: SUCCESS (0.363s)
[250.829297] [071/132] (772s left) kms_flip (flip-vs-expired-vblank)
[250.922416] Starting subtest: flip-vs-expired-vblank
[250.924688] Starting dynamic subtest: A-eDP1
[259.626480] Dynamic subtest A-eDP1: SUCCESS (8.666s)
[259.638116] Starting dynamic subtest: B-eDP1
[268.252439] Dynamic subtest B-eDP1: SUCCESS (8.624s)
[268.263460] Starting dynamic subtest: C-eDP1
[276.891731] Dynamic subtest C-eDP1: SUCCESS (8.623s)
[276.902995] Starting dynamic subtest: D-eDP1
[285.523599] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[285.529193] Subtest flip-vs-expired-vblank: SUCCESS (34.552s)
[286.647879] [072/132] (737s left) perf_pmu (faulting-read)
[286.695425] Starting subtest: faulting-read
[286.697898] Starting dynamic subtest: wb
[286.700366] Dynamic subtest wb: SUCCESS (0.002s)
[286.719078] Starting dynamic subtest: wc
[286.721077] Dynamic subtest wc: SUCCESS (0.001s)
[286.739186] Starting dynamic subtest: uc
[286.741227] Dynamic subtest uc: SUCCESS (0.001s)
[286.743210] Subtest faulting-read: SUCCESS (0.006s)
[286.833558] [073/132] (736s left) i915_pm_sseu (full-enable)
[286.891325] Subtest full-enable: SKIP (0.000s)
[286.982389] [074/132] (736s left) perf (disabled-read-error)
[287.099730] Starting subtest: disabled-read-error
[287.115845] Subtest disabled-read-error: SUCCESS (0.017s)
[287.156459] [075/132] (736s left) kms_async_flips (alternate-sync-async-flip-atomic)
[287.264005] Starting subtest: alternate-sync-async-flip-atomic
[287.636240] Starting dynamic subtest: pipe-A-eDP-1
[290.436971] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.801s)
[290.823837] Starting dynamic subtest: pipe-B-eDP-1
[293.566327] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.757s)
[293.946693] Starting dynamic subtest: pipe-C-eDP-1
[296.703854] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s)
[297.082878] Starting dynamic subtest: pipe-D-eDP-1
[299.828213] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.752s)
[299.830301] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.565s)
[300.997930] [076/132] (722s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[301.090610] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[301.092944] Starting dynamic subtest: pipe-A
[301.201420] Dynamic subtest pipe-A: SKIP (0.107s)
[301.211310] Starting dynamic subtest: pipe-B
[302.383434] Dynamic subtest pipe-B: SKIP (1.182s)
[302.397771] Starting dynamic subtest: pipe-C
[303.510793] Dynamic subtest pipe-C: SUCCESS (1.131s)
[303.519554] Starting dynamic subtest: pipe-D
[304.662938] Dynamic subtest pipe-D: SUCCESS (1.151s)
[304.665275] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.574s)
[305.861416] [077/132] (718s left) syncobj_wait (multi-wait-signaled)
[305.916777] Starting subtest: multi-wait-signaled
[305.919034] Subtest multi-wait-signaled: SUCCESS (0.000s)
[306.019019] [078/132] (717s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[306.075500] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[306.182756] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[306.267884] [079/132] (717s left) gem_eio (in-flight-contexts-10ms)
[306.486060] Starting subtest: in-flight-contexts-10ms
[320.046513] Subtest in-flight-contexts-10ms: SUCCESS (13.558s)
[320.226239] [080/132] (703s left) i915_pm_rpm (gem-execbuf-stress)
[322.168354] Starting subtest: gem-execbuf-stress
[322.170639] Starting dynamic subtest: smem0
[336.028323] Dynamic subtest smem0: SUCCESS (13.859s)
[336.040066] Starting dynamic subtest: extra-wait-smem0
[398.069009] Dynamic subtest extra-wait-smem0: SUCCESS (61.970s)
[398.071942] Subtest gem-execbuf-stress: SUCCESS (75.837s)
[398.402787] [081/132] (625s left) syncobj_wait (single-wait-all-for-submit-signaled)
[398.466477] Starting subtest: single-wait-all-for-submit-signaled
[398.468707] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[398.556518] [082/132] (625s left) gem_exec_balancer (busy)
[398.628089] Starting subtest: busy
[400.022681] Subtest busy: SUCCESS (1.393s)
[400.340130] [083/132] (623s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[400.441995] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[400.446395] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[400.538795] [084/132] (623s left) kms_lease (empty-lease)
[400.632561] Starting subtest: empty-lease
[400.634898] Starting dynamic subtest: pipe-A-eDP-1
[400.637229] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[400.647359] Starting dynamic subtest: pipe-B-eDP-1
[400.649624] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[400.658478] Starting dynamic subtest: pipe-C-eDP-1
[400.660675] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[400.669674] Starting dynamic subtest: pipe-D-eDP-1
[400.671907] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[400.674109] Subtest empty-lease: SUCCESS (0.009s)
[400.741557] [085/132] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[400.826834] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[400.831265] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[400.911438] [086/132] (623s left) gem_basic (create-close)
[400.966002] Starting subtest: create-close
[400.970505] Subtest create-close: SUCCESS (0.000s)
[401.058603] [087/132] (623s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[401.146065] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[401.148149] Starting dynamic subtest: pipe-A-eDP-1
[401.167635] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[401.179569] Starting dynamic subtest: pipe-B-eDP-1
[401.199085] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[401.207835] Starting dynamic subtest: pipe-C-eDP-1
[401.226474] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[401.234706] Starting dynamic subtest: pipe-D-eDP-1
[401.251043] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[401.252870] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[403.472351] [088/132] (620s left) kms_invalid_mode (bad-hsync-end)
[403.569579] Starting subtest: bad-hsync-end
[403.571955] Starting dynamic subtest: pipe-A-eDP-1
[403.855756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[403.865532] Starting dynamic subtest: pipe-B-eDP-1
[403.867467] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[403.876125] Starting dynamic subtest: pipe-C-eDP-1
[403.878056] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[403.887070] Starting dynamic subtest: pipe-D-eDP-1
[403.889179] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[403.891300] Subtest bad-hsync-end: SUCCESS (0.293s)
[404.702190] [089/132] (619s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[404.809172] Starting subtest: yf-tiled-32bpp-rotate-0
[404.813597] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[404.917871] [090/132] (619s left) prime_vgem (basic-gtt)
[404.980297] Starting subtest: basic-gtt
[404.984564] Subtest basic-gtt: SKIP (0.000s)
[405.092876] [091/132] (619s left) kms_big_fb (linear-16bpp-rotate-180)
[405.187195] Starting subtest: linear-16bpp-rotate-180
[406.621305] Subtest linear-16bpp-rotate-180: SUCCESS (1.433s)
[406.743978] [092/132] (617s left) kms_properties (get_properties-sanity-atomic)
[406.843914] Starting subtest: get_properties-sanity-atomic
[406.845934] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[406.946342] [093/132] (617s left) kms_psr (pr-sprite-plane-onoff)
[407.054900] Starting subtest: pr-sprite-plane-onoff
[407.058561] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[407.133331] [094/132] (617s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[407.234649] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[407.238066] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[407.304380] [095/132] (617s left) kms_prop_blob (blob-prop-validate)
[407.364143] Starting subtest: blob-prop-validate
[407.366120] Subtest blob-prop-validate: SUCCESS (0.000s)
[407.472587] [096/132] (617s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[407.562086] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[407.565305] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[407.648576] [097/132] (617s left) perf_pmu (semaphore-busy)
[407.695580] Starting subtest: semaphore-busy
[407.697501] Starting dynamic subtest: rcs0
[409.340305] Dynamic subtest rcs0: SUCCESS (1.638s)
[409.351557] Starting dynamic subtest: bcs0
[410.971074] Dynamic subtest bcs0: SUCCESS (1.628s)
[410.983324] Starting dynamic subtest: vcs0
[415.509731] Dynamic subtest vcs0: SUCCESS (4.534s)
[415.523591] Starting dynamic subtest: vcs1
[421.577372] Dynamic subtest vcs1: SUCCESS (6.011s)
[421.589038] Starting dynamic subtest: vecs0
[427.592187] Dynamic subtest vecs0: SUCCESS (6.011s)
[427.603795] Starting dynamic subtest: ccs0
[430.617191] Dynamic subtest ccs0: SUCCESS (3.072s)
[430.619812] Subtest semaphore-busy: SUCCESS (22.913s)
[430.730676] [098/132] (594s left) gem_ctx_persistence (heartbeat-hang)
[430.795562] Starting subtest: heartbeat-hang
[430.799943] Subtest heartbeat-hang: SKIP (0.000s)
[430.891671] [099/132] (593s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[430.986587] Starting subtest: 4-tiled-8bpp-rotate-90
[431.009338] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.022s)
[431.115773] [100/132] (593s left) gem_softpin (noreloc-s3)
[431.174006] Starting subtest: noreloc-S3
[451.127842] Subtest noreloc-S3: SUCCESS (5.400s)
[451.230990] [101/132] (573s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[451.352349] Starting subtest: cursorA-vs-flipB-legacy
[451.356915] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[451.520057] [102/132] (573s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[451.628227] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[451.632570] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[451.715659] [103/132] (573s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[451.818381] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[451.822949] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[451.935810] [104/132] (573s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[452.025473] Starting subtest: primary-4-tiled-reflect-x-180
[459.014199] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.983s)
[460.191461] [105/132] (564s left) gem_ctx_engines (execute-oneforall)
[460.247993] Starting subtest: execute-oneforall
[460.793981] Subtest execute-oneforall: SUCCESS (0.545s)
[461.681639] [106/132] (563s left) gen9_exec_parse (allowed-single)
[461.734301] Subtest allowed-single: SKIP (0.000s)
[461.807361] [107/132] (563s left) kms_flip (flip-vs-blocking-wf-vblank)
[461.908279] Starting subtest: flip-vs-blocking-wf-vblank
[461.910508] Starting dynamic subtest: A-eDP1
[470.836836] Dynamic subtest A-eDP1: SUCCESS (8.925s)
[470.848600] Starting dynamic subtest: B-eDP1
[479.777572] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[479.791163] Starting dynamic subtest: C-eDP1
[488.741243] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[488.750986] Starting dynamic subtest: D-eDP1
[497.681130] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[497.683588] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.715s)
[498.866182] [108/132] (526s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[498.976016] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[502.476695] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.503s)
[503.653254] [109/132] (521s left) gem_exec_suspend (basic-s3-devices)
[503.718724] Starting subtest: basic-S3-devices
[503.721107] Starting dynamic subtest: smem
[515.564169] Dynamic subtest smem: SUCCESS (11.841s)
[515.567181] Subtest basic-S3-devices: SUCCESS (11.843s)
[515.748129] [110/132] (509s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[515.814779] Starting subtest: etime-multi-wait-all-available-unsubmitted
[515.916786] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.104s)
[515.996594] [111/132] (509s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[516.100934] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[516.105200] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[516.175086] [112/132] (509s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[516.274423] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[522.992230] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.721s)
[523.098349] [113/132] (502s left) dumb_buffer (map-uaf)
[523.163265] Starting subtest: map-uaf
[523.169207] Subtest map-uaf: SUCCESS (0.007s)
[523.304151] [114/132] (502s left) gem_exec_basic (basic)
[523.374434] Starting subtest: basic
[523.376684] Starting dynamic subtest: rcs0-smem
[523.378989] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[523.390564] Starting dynamic subtest: bcs0-smem
[523.392425] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[523.401066] Starting dynamic subtest: vcs0-smem
[523.402937] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[523.411792] Starting dynamic subtest: vcs1-smem
[523.413681] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[523.422383] Starting dynamic subtest: vecs0-smem
[523.424301] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[523.432566] Starting dynamic subtest: ccs0-smem
[523.434486] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[523.436382] Subtest basic: SUCCESS (0.015s)
[524.640598] [115/132] (500s left) i915_drm_fdinfo (isolation)
[524.686290] Starting subtest: isolation
[524.688458] Starting dynamic subtest: rcs0
[524.705728] Dynamic subtest rcs0: SKIP (0.018s)
[524.716196] Starting dynamic subtest: bcs0
[524.723213] Dynamic subtest bcs0: SKIP (0.016s)
[524.732791] Starting dynamic subtest: vcs0
[524.737415] Dynamic subtest vcs0: SKIP (0.001s)
[524.746823] Starting dynamic subtest: vcs1
[524.751002] Dynamic subtest vcs1: SKIP (0.000s)
[524.760114] Starting dynamic subtest: vecs0
[524.764544] Dynamic subtest vecs0: SKIP (0.000s)
[524.773307] Starting dynamic subtest: ccs0
[524.777704] Dynamic subtest ccs0: SKIP (0.000s)
[524.782089] Subtest isolation: SKIP (0.041s)
[524.819197] [116/132] (500s left) kms_flip (basic-plain-flip)
[524.920616] Starting subtest: basic-plain-flip
[524.922824] Starting dynamic subtest: A-eDP1
[526.599328] Dynamic subtest A-eDP1: SUCCESS (1.679s)
[526.615973] Starting dynamic subtest: B-eDP1
[528.317620] Dynamic subtest B-eDP1: SUCCESS (1.716s)
[528.334201] Starting dynamic subtest: C-eDP1
[529.958728] Dynamic subtest C-eDP1: SUCCESS (1.627s)
[529.970946] Starting dynamic subtest: D-eDP1
[531.572096] Dynamic subtest D-eDP1: SUCCESS (1.623s)
[531.577975] Subtest basic-plain-flip: SUCCESS (6.658s)
[532.744976] [117/132] (492s left) kms_flip (2x-plain-flip-ts-check)
[532.846980] Starting subtest: 2x-plain-flip-ts-check
[532.855537] Subtest 2x-plain-flip-ts-check: SKIP (0.010s)
[532.937333] [118/132] (492s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[532.995622] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[533.063791] [119/132] (492s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[533.164475] Starting subtest: drrs-dirtyfb-ioctl
[533.177188] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[533.266317] [120/132] (492s left) kms_rotation_crc (sprite-rotation-90)
[533.356167] Starting subtest: sprite-rotation-90
[533.360215] Subtest sprite-rotation-90: SKIP (0.001s)
[533.432120] [121/132] (492s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[533.518949] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[533.523155] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[533.601979] [122/132] (492s left) syncobj_timeline (multi-wait-signaled)
[533.665093] Starting subtest: multi-wait-signaled
[533.667364] Subtest multi-wait-signaled: SUCCESS (0.001s)
[533.792199] [123/132] (492s left) dmabuf_sync_file (import-multiple-read-only)
[533.841971] Starting subtest: import-multiple-read-only
[533.843887] Subtest import-multiple-read-only: SUCCESS (0.003s)
[533.895115] [124/132] (492s left) gem_workarounds (basic-read-fd)
[533.978263] Starting subtest: basic-read-fd
[533.989012] Subtest basic-read-fd: SUCCESS (0.011s)
[534.104179] [125/132] (491s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[534.191200] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[534.194689] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[534.315072] [126/132] (491s left) gem_exec_flush (basic-wb-pro-default)
[534.364207] Starting subtest: basic-wb-pro-default
[539.851549] Subtest basic-wb-pro-default: SUCCESS (5.467s)
[540.024088] [127/132] (486s left) kms_atomic (atomic-invalid-params)
[540.126546] Starting subtest: atomic-invalid-params
[540.128908] Starting dynamic subtest: pipe-A-eDP-1
[540.515969] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.389s)
[540.518430] Subtest atomic-invalid-params: SUCCESS (0.391s)
[541.371359] [128/132] (484s left) gem_exec_schedule (preemptive-hang)
[541.538824] Starting subtest: preemptive-hang
[541.541405] Starting dynamic subtest: rcs0
[550.684631] Dynamic subtest rcs0: SUCCESS (9.142s)
[550.695092] Starting dynamic subtest: bcs0
[559.704149] Dynamic subtest bcs0: SUCCESS (9.009s)
[559.713924] Starting dynamic subtest: vcs0
[568.727460] Dynamic subtest vcs0: SUCCESS (9.023s)
[568.738825] Starting dynamic subtest: vcs1
[577.684638] Dynamic subtest vcs1: SUCCESS (8.961s)
[577.694933] Starting dynamic subtest: vecs0
[586.711878] Dynamic subtest vecs0: SUCCESS (9.012s)
[586.724550] Starting dynamic subtest: ccs0
[595.673293] Dynamic subtest ccs0: SUCCESS (8.959s)
[595.675620] Subtest preemptive-hang: SUCCESS (54.115s)
[595.912782] [129/132] (430s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[596.005001] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[596.006941] Starting dynamic subtest: pipe-A-eDP-1
[596.451014] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[596.463551] Starting dynamic subtest: pipe-B-eDP-1
[596.484153] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[596.493978] Starting dynamic subtest: pipe-C-eDP-1
[596.513186] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[596.522527] Starting dynamic subtest: pipe-D-eDP-1
[596.541977] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[596.544122] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.460s)
[598.747442] [130/132] (427s left) gem_mmap_offset (bad-flags)
[598.793989] Starting subtest: bad-flags
[598.796563] Subtest bad-flags: SUCCESS (0.000s)
[598.896623] [131/132] (427s left) gem_exec_whisper (basic-normal-all)
[598.959830] Starting subtest: basic-normal-all
[601.313324] Subtest basic-normal-all: SUCCESS (2.352s)
[601.513074] [132/132] (424s left) kms_cursor_crc (cursor-offscreen-512x512)
[601.806523] Starting subtest: cursor-offscreen-512x512
[601.810770] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[601.986732] Closing watchdogs
results: parsing output: 0/ for test: gem_spin_batch
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: gem_partial_pwrite_pread
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: gem_huc_copy
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: sysfs_heartbeat_interval
results: parsing output: 10/ for test: gen3_render_tiledy_blits
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: gem_userptr_blits
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_chamelium_color
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: prime_vgem
results: parsing output: 24/ for test: kms_addfb_basic
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_force_connector_basic
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: gem_set_tiling_vs_blt
results: parsing output: 32/ for test: kms_vblank
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: kms_color
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: i915_query
results: parsing output: 37/ for test: kms_sequence
results: parsing output: 38/ for test: gem_pxp
results: parsing output: 39/ for test: i915_drm_fdinfo
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: sw_sync
results: parsing output: 42/ for test: kms_pipe_crc_basic
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_chamelium_color
results: parsing output: 45/ for test: kms_getfb
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_properties
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: kms_plane
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: gem_pwrite
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: api_intel_bb
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: api_intel_allocator
results: parsing output: 61/ for test: kms_flip_scaled_crc
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: gem_ctx_shared
results: parsing output: 65/ for test: kms_pm_lpsp
results: parsing output: 66/ for test: kms_plane_lowres
results: parsing output: 67/ for test: kms_dsc
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: i915_pm_sseu
results: parsing output: 73/ for test: perf
results: parsing output: 74/ for test: kms_async_flips
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: gem_eio
results: parsing output: 79/ for test: i915_pm_rpm
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_lease
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_basic
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_invalid_mode
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_properties
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_prop_blob
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_softpin
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_rotation_crc
results: parsing output: 104/ for test: gem_ctx_engines
results: parsing output: 105/ for test: gen9_exec_parse
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_suspend
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: dumb_buffer
results: parsing output: 113/ for test: gem_exec_basic
results: parsing output: 114/ for test: i915_drm_fdinfo
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: kms_dirtyfb
results: parsing output: 119/ for test: kms_rotation_crc
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: dmabuf_sync_file
results: parsing output: 123/ for test: gem_workarounds
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_flush
results: parsing output: 126/ for test: kms_atomic
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: gem_mmap_offset
results: parsing output: 130/ for test: gem_exec_whisper
results: parsing output: 131/ for test: kms_cursor_crc
Done.