[59.097265] Initializing watchdogs
[59.097307]   /dev/watchdog0
[59.111204] [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.115300] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.117486] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.120954] [001/133] (960s left) syncobj_wait (multi-wait-submitted-signaled)
[59.196739] Starting subtest: multi-wait-submitted-signaled
[59.199050] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[59.312582] [002/133] (960s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[59.399929] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[59.402339] Starting dynamic subtest: pipe-A-eDP-1
[59.426066] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[59.435270] Starting dynamic subtest: pipe-B-eDP-1
[59.455784] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[59.462253] Starting dynamic subtest: pipe-C-eDP-1
[59.483285] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[59.490062] Starting dynamic subtest: pipe-D-eDP-1
[59.514045] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[59.518496] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s)
[61.582266] [003/133] (958s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[61.690925] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[61.693134] Starting dynamic subtest: pipe-A
[62.026206] Dynamic subtest pipe-A: SUCCESS (0.339s)
[62.033249] Starting dynamic subtest: pipe-B
[63.461875] Dynamic subtest pipe-B: SUCCESS (1.440s)
[63.469331] Starting dynamic subtest: pipe-C
[64.892312] Dynamic subtest pipe-C: SUCCESS (1.435s)
[64.899205] Starting dynamic subtest: pipe-D
[66.324176] Dynamic subtest pipe-D: SUCCESS (1.435s)
[66.326790] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.650s)
[67.546404] [004/133] (952s left) gem_ccs (block-copy-compressed)
[67.663271] Starting subtest: block-copy-compressed
[67.667856] Subtest block-copy-compressed: SKIP (0.000s)
[67.928192] [005/133] (951s left) i915_query (query-topology-coherent-slice-mask)
[68.017667] Starting subtest: query-topology-coherent-slice-mask
[68.022097] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[68.137532] [006/133] (951s left) syncobj_timeline (invalid-transfer-bad-pad)
[68.200284] Starting subtest: invalid-transfer-bad-pad
[68.202374] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[68.296943] [007/133] (951s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[68.381298] Starting subtest: primary-x-tiled-reflect-x-180
[75.343197] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.971s)
[76.567771] [008/133] (943s left) kms_vrr (max-min)
[76.664091] Starting subtest: max-min
[76.670351] Subtest max-min: SKIP (0.000s)
[76.742829] [009/133] (943s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[76.849040] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[83.462842] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.621s)
[83.632052] [010/133] (936s left) kms_psr (pr-cursor-mmap-gtt)
[83.752316] Starting subtest: pr-cursor-mmap-gtt
[83.756770] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[83.844268] [011/133] (936s left) gem_sync (basic-all)
[83.917774] Starting subtest: basic-all
[87.896714] Subtest basic-all: SUCCESS (3.989s)
[88.091030] [012/133] (931s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[88.166705] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[88.171226] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[88.360341] [013/133] (931s left) kms_atomic_interruptible (atomic-setmode)
[88.455592] Starting subtest: atomic-setmode
[88.457834] Starting dynamic subtest: pipe-A-eDP-1
[95.350546] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.894s)
[95.352830] Subtest atomic-setmode: SUCCESS (6.894s)
[96.158546] [014/133] (923s left) gem_pxp (reject-modify-context-protection-off-3)
[96.284855] Starting subtest: reject-modify-context-protection-off-3
[96.288053] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[96.429791] [015/133] (923s left) kms_pm_dc (dc5-dpms)
[97.535913] Starting subtest: dc5-dpms
[99.630531] Subtest dc5-dpms: SUCCESS (2.094s)
[99.728458] [016/133] (920s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[99.835334] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[99.837805] Starting dynamic subtest: pipe-A
[100.175146] Dynamic subtest pipe-A: SUCCESS (0.340s)
[100.185855] Starting dynamic subtest: pipe-B
[101.564013] Dynamic subtest pipe-B: SUCCESS (1.388s)
[101.572042] Starting dynamic subtest: pipe-C
[103.014640] Dynamic subtest pipe-C: SUCCESS (1.450s)
[103.022130] Starting dynamic subtest: pipe-D
[104.424696] Dynamic subtest pipe-D: SUCCESS (1.410s)
[104.427110] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.590s)
[105.598967] [017/133] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[105.705967] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[105.710740] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[105.830867] [018/133] (914s left) gem_exec_reloc (basic-wc-read)
[105.890404] Subtest basic-wc-read: SKIP (0.000s)
[105.955721] [019/133] (914s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[106.053814] Starting subtest: fbc-rgb101010-draw-render
[110.636039] Subtest fbc-rgb101010-draw-render: SUCCESS (4.587s)
[111.806347] [020/133] (908s left) gem_exec_schedule (semaphore-user)
[111.880040] Starting subtest: semaphore-user
[111.934314] Subtest semaphore-user: SUCCESS (0.056s)
[113.933319] [021/133] (906s left) kms_pm_rpm (universal-planes-dpms)
[116.079453] Starting subtest: universal-planes-dpms
[116.082621] Starting dynamic subtest: plane-34
[124.415764] Dynamic subtest plane-34: SUCCESS (8.336s)
[124.425787] Starting dynamic subtest: plane-64
[132.735387] Dynamic subtest plane-64: SUCCESS (8.317s)
[132.745699] Starting dynamic subtest: plane-94
[141.031885] Dynamic subtest plane-94: SUCCESS (8.295s)
[141.041996] Starting dynamic subtest: plane-124
[149.409377] Dynamic subtest plane-124: SUCCESS (8.375s)
[149.419329] Starting dynamic subtest: plane-134
[157.803529] Dynamic subtest plane-134: SUCCESS (8.391s)
[157.814180] Starting dynamic subtest: plane-144
[166.389955] Dynamic subtest plane-144: SUCCESS (8.584s)
[166.392938] Subtest universal-planes-dpms: SUCCESS (50.310s)
[166.782267] [022/133] (853s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[166.898349] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[166.902699] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[167.029227] [023/133] (853s left) syncobj_wait (reset-multiple-signaled)
[167.092367] Starting subtest: reset-multiple-signaled
[167.094333] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[167.208239] [024/133] (853s left) gem_ctx_param (set-priority-range)
[167.265760] Starting subtest: set-priority-range
[167.279968] Subtest set-priority-range: SUCCESS (0.014s)
[167.409162] [025/133] (853s left) gem_exec_whisper (basic-queues-forked)
[167.480094] Starting subtest: basic-queues-forked
[191.898842] Subtest basic-queues-forked: SUCCESS (24.413s)
[192.092541] [026/133] (828s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[192.202903] Starting subtest: basic-max-pipe-crc-check
[192.207376] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[192.248086] [027/133] (828s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[192.340234] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[192.370756] Starting dynamic subtest: pipe-A-plane-0
[192.658895] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[192.666839] Starting dynamic subtest: pipe-A-plane-3
[192.881530] Dynamic subtest pipe-A-plane-3: SUCCESS (0.222s)
[192.890076] Starting dynamic subtest: pipe-A-plane-5
[192.894500] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[193.947875] Starting dynamic subtest: pipe-B-plane-0
[194.219428] Dynamic subtest pipe-B-plane-0: SUCCESS (0.278s)
[194.229659] Starting dynamic subtest: pipe-B-plane-3
[194.452140] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[194.460710] Starting dynamic subtest: pipe-B-plane-5
[194.465690] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[194.773522] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.430s)
[195.644664] [028/133] (825s left) gem_wait (write-busy)
[195.706992] Starting subtest: write-busy
[195.709655] Starting dynamic subtest: all-engines
[196.365924] Dynamic subtest all-engines: SUCCESS (0.658s)
[196.381600] Starting dynamic subtest: rcs0
[196.916405] Dynamic subtest rcs0: SUCCESS (0.549s)
[196.931498] Starting dynamic subtest: bcs0
[197.464793] Dynamic subtest bcs0: SUCCESS (0.547s)
[197.479547] Starting dynamic subtest: vcs0
[198.932887] Dynamic subtest vcs0: SUCCESS (1.466s)
[198.947042] Starting dynamic subtest: vcs1
[200.919387] Dynamic subtest vcs1: SUCCESS (1.984s)
[200.933907] Starting dynamic subtest: vecs0
[202.902443] Dynamic subtest vecs0: SUCCESS (1.981s)
[202.919621] Starting dynamic subtest: ccs0
[203.453193] Dynamic subtest ccs0: SUCCESS (0.550s)
[203.455751] Subtest write-busy: SUCCESS (7.746s)
[203.659429] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[203.662897] [029/133] (817s left) kms_addfb_basic (bad-pitch-65536)
[203.715128] Starting subtest: bad-pitch-65536
[203.717356] Subtest bad-pitch-65536: SUCCESS (0.000s)
[203.891619] [030/133] (816s left) kms_flip (plain-flip-ts-check)
[203.997266] Starting subtest: plain-flip-ts-check
[203.999596] Starting dynamic subtest: A-eDP1
[212.834871] Dynamic subtest A-eDP1: SUCCESS (8.839s)
[212.843197] Starting dynamic subtest: B-eDP1
[221.757207] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[221.767069] Starting dynamic subtest: C-eDP1
[230.576476] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[230.584332] Starting dynamic subtest: D-eDP1
[239.412859] Dynamic subtest D-eDP1: SUCCESS (8.835s)
[239.418037] Subtest plain-flip-ts-check: SUCCESS (35.423s)
[240.614641] [031/133] (780s left) gem_userptr_blits (unsync-unmap-cycles)
[240.693338] Subtest unsync-unmap-cycles: SKIP (0.000s)
[240.840657] [032/133] (779s left) gem_mmap_offset (basic-uaf)
[240.916906] Starting subtest: basic-uaf
[240.919133] Subtest basic-uaf: SUCCESS (0.001s)
[241.063461] [033/133] (779s left) core_getversion (all-cards)
[241.101200] Starting subtest: all-cards
[241.120598] Subtest all-cards: SUCCESS (0.021s)
[241.160080] [034/133] (779s left) gem_exec_whisper (basic-contexts)
[241.222999] Starting subtest: basic-contexts
[246.974985] Subtest basic-contexts: SUCCESS (5.748s)
[247.164876] [035/133] (773s left) kms_feature_discovery (display)
[247.258886] Starting subtest: display
[247.261160] Subtest display: SUCCESS (0.000s)
[247.346071] [036/133] (773s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[247.436056] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[254.251191] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.816s)
[254.421396] [037/133] (766s left) gem_mmap_wc (bad-offset)
[254.488201] Subtest bad-offset: SKIP (0.000s)
[254.549940] [038/133] (766s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[254.673425] Starting subtest: cursorB-vs-flipB-varying-size
[254.678072] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[254.843496] [039/133] (766s left) perf_pmu (module-unload)
[254.937512] Starting subtest: module-unload
[261.629163] Subtest module-unload: FAIL (6.589s)
[261.660574] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[261.661313] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[261.664385] [040/133] (759s left) i915_hangman (detector)
[263.137084] Starting subtest: detector
[263.139596] Starting dynamic subtest: rcs0
[274.868284] Dynamic subtest rcs0: SUCCESS (11.731s)
[274.878129] Starting dynamic subtest: bcs0
[286.837260] Dynamic subtest bcs0: SUCCESS (11.966s)
[286.847959] Starting dynamic subtest: vcs0
[298.805884] Dynamic subtest vcs0: SUCCESS (11.966s)
[298.816539] Starting dynamic subtest: vcs1
[309.812263] Dynamic subtest vcs1: SUCCESS (11.003s)
[309.823054] Starting dynamic subtest: vecs0
[319.796296] Dynamic subtest vecs0: SUCCESS (9.981s)
[319.808455] Starting dynamic subtest: ccs0
[330.867465] Dynamic subtest ccs0: SUCCESS (11.069s)
[330.870096] Subtest detector: SUCCESS (67.730s)
[331.007550] [FACT i915_hangman (detector)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[331.008836] [FACT i915_hangman (detector)] new: kernel.kmod_is_loaded.i915: true
[331.012985] [041/133] (690s left) syncobj_basic (create-signaled)
[331.073448] Starting subtest: create-signaled
[331.075407] Subtest create-signaled: SUCCESS (0.000s)
[331.198937] [042/133] (690s left) gem_exec_fence (submit3)
[331.381029] Starting subtest: submit3
[331.385757] Subtest submit3: SKIP (0.000s)
[333.011456] [043/133] (688s left) kms_chamelium_edid (hdmi-edid-read)
[333.401281] Subtest hdmi-edid-read: SKIP (0.000s)
[334.240507] [044/133] (687s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[334.335371] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[334.337576] Starting dynamic subtest: pipe-A-eDP-1
[334.359723] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[334.369680] Starting dynamic subtest: pipe-B-eDP-1
[334.391258] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[334.398078] Starting dynamic subtest: pipe-C-eDP-1
[334.418630] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[334.425602] Starting dynamic subtest: pipe-D-eDP-1
[334.447204] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[334.451582] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[336.656218] [045/133] (684s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[336.754212] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[343.354549] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.600s)
[343.505922] [046/133] (677s left) syncobj_timeline (etime-single-wait-all-submitted)
[343.568638] Starting subtest: etime-single-wait-all-submitted
[343.672853] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[343.763611] [047/133] (677s left) gem_exec_capture (pi)
[343.838396] Starting subtest: pi
[343.840714] Starting dynamic subtest: rcs0
[348.181202] Dynamic subtest rcs0: SUCCESS (4.344s)
[348.192327] Starting dynamic subtest: bcs0
[352.260861] Dynamic subtest bcs0: SUCCESS (4.077s)
[352.271567] Starting dynamic subtest: vcs0
[356.363559] Dynamic subtest vcs0: SUCCESS (4.100s)
[356.379220] Starting dynamic subtest: vcs1
[360.421734] Dynamic subtest vcs1: SUCCESS (4.056s)
[360.431060] Starting dynamic subtest: vecs0
[364.481579] Dynamic subtest vecs0: SUCCESS (4.059s)
[364.489717] Starting dynamic subtest: ccs0
[368.545300] Dynamic subtest ccs0: SUCCESS (4.061s)
[368.547800] Subtest pi: SUCCESS (24.710s)
[368.636362] [048/133] (652s left) kms_flip (nonblocking-read)
[368.778072] Starting subtest: nonblocking-read
[368.779930] Subtest nonblocking-read: SUCCESS (0.000s)
[368.889034] [049/133] (652s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[368.997426] Starting subtest: yf-tiled-16bpp-rotate-90
[369.003319] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[369.136603] [050/133] (652s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[369.242799] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[369.247204] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[369.339884] [051/133] (652s left) gem_softpin (full)
[369.409847] Starting subtest: full
[369.418532] Subtest full: SUCCESS (0.009s)
[369.570526] [052/133] (652s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[369.954543] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[370.765455] [053/133] (650s left) perf (rc6-disable)
[370.908063] Starting subtest: rc6-disable
[371.095802] Subtest rc6-disable: SUCCESS (0.189s)
[371.136031] [054/133] (650s left) gem_partial_pwrite_pread (reads-snoop)
[371.211353] Subtest reads-snoop: SKIP (0.000s)
[371.290151] [055/133] (650s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[371.577107] Starting subtest: cursor-rapid-movement-512x512
[371.581124] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[371.741159] [056/133] (650s left) gem_mmap_gtt (cpuset-big-copy)
[371.790661] Subtest cpuset-big-copy: SKIP (0.000s)
[371.846913] [057/133] (649s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[371.960588] Starting subtest: modeset-atomic-cursor-hotspot
[371.964774] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[372.113442] [058/133] (649s left) kms_psr (psr-sprite-mmap-cpu)
[372.210979] Starting subtest: psr-sprite-mmap-cpu
[372.213474] Starting dynamic subtest: eDP-1
[373.913171] Dynamic subtest eDP-1: SUCCESS (1.701s)
[373.915508] Subtest psr-sprite-mmap-cpu: SUCCESS (1.702s)
[374.763403] [059/133] (647s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[374.858410] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[374.862444] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[375.009323] [060/133] (646s left) gem_exec_reloc (basic-wc-cpu-active)
[375.071563] Subtest basic-wc-cpu-active: SKIP (0.000s)
[375.169168] [061/133] (646s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[375.268922] Starting subtest: basic-modeset-with-all-modifiers-formats
[375.639645] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[376.436880] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.798s)
[376.446183] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[376.458529] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[376.466845] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[376.480685] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[376.489845] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[376.625342] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[376.635115] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[376.647435] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[376.656150] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[376.669684] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[376.678850] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[376.692052] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[376.700213] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[376.714136] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[376.722345] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[376.736245] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[376.744149] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[376.758522] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[376.766865] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[376.780794] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[376.790190] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[376.803133] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[376.813607] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[376.947455] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[376.957072] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[376.969574] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[376.978363] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[376.991991] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[377.000366] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[377.014158] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[377.023283] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[377.036300] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[377.044731] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[377.058508] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[377.066929] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[377.080803] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[377.089247] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[377.103109] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[377.111285] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[377.125277] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[377.133654] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[377.281086] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[377.291658] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[377.302927] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[377.311251] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[377.325217] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[377.333229] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[377.347475] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[377.355433] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[377.369695] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[377.378107] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[377.391849] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[377.399783] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[377.414125] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[377.421960] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[377.436370] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[377.444554] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[377.458876] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[377.847841] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.581s)
[378.623308] [062/133] (643s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[378.724849] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[378.729469] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[379.860513] [063/133] (642s left) kms_flip (flip-vs-dpms-on-nop)
[379.968664] Starting subtest: flip-vs-dpms-on-nop
[379.970981] Starting dynamic subtest: A-eDP1
[381.836227] Dynamic subtest A-eDP1: SUCCESS (1.867s)
[381.846503] Starting dynamic subtest: B-eDP1
[383.670412] Dynamic subtest B-eDP1: SUCCESS (1.832s)
[383.681095] Starting dynamic subtest: C-eDP1
[385.502449] Dynamic subtest C-eDP1: SUCCESS (1.830s)
[385.516996] Starting dynamic subtest: D-eDP1
[387.323187] Dynamic subtest D-eDP1: SUCCESS (1.819s)
[387.325687] Subtest flip-vs-dpms-on-nop: SUCCESS (7.358s)
[388.512560] [064/133] (633s left) vgem_basic (unload)
[388.552038] Starting subtest: unload
[417.724451] Subtest unload: SUCCESS (29.174s)
[417.835400] [065/133] (604s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[417.949081] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[417.951378] Starting dynamic subtest: pipe-A-default-mode
[419.066522] Dynamic subtest pipe-A-default-mode: SKIP (1.116s)
[419.071240] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.117s)
[419.238385] [066/133] (602s left) syncobj_wait (multi-wait-signaled)
[419.297426] Starting subtest: multi-wait-signaled
[419.299624] Subtest multi-wait-signaled: SUCCESS (0.000s)
[419.427426] [067/133] (602s left) kms_properties (get_properties-sanity-atomic)
[419.518334] Starting subtest: get_properties-sanity-atomic
[419.523635] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[419.602314] [068/133] (602s left) sysfs_heartbeat_interval (nopreempt)
[419.671485] Starting subtest: nopreempt
[419.673620] Starting dynamic subtest: vecs0
[428.912491] Dynamic subtest vecs0: SUCCESS (9.241s)
[428.923970] Starting dynamic subtest: ccs0
[433.036950] Dynamic subtest ccs0: SUCCESS (4.123s)
[433.050421] Starting dynamic subtest: vcs0
[442.929987] Dynamic subtest vcs0: SUCCESS (9.889s)
[442.940942] Starting dynamic subtest: bcs0
[446.939037] Dynamic subtest bcs0: SUCCESS (4.008s)
[446.950274] Starting dynamic subtest: rcs0
[451.012318] Dynamic subtest rcs0: SUCCESS (4.071s)
[451.023706] Starting dynamic subtest: vcs1
[460.910748] Dynamic subtest vcs1: SUCCESS (9.896s)
[460.913282] Subtest nopreempt: SUCCESS (41.240s)
[460.999287] [069/133] (561s left) kms_async_flips (test-time-stamp-atomic)
[461.106137] Starting subtest: test-time-stamp-atomic
[461.479114] Starting dynamic subtest: pipe-A-eDP-1
[462.246163] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.766s)
[462.639852] Starting dynamic subtest: pipe-B-eDP-1
[463.391551] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.758s)
[463.755891] Starting dynamic subtest: pipe-C-eDP-1
[464.522649] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.771s)
[464.902202] Starting dynamic subtest: pipe-D-eDP-1
[465.660415] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.763s)
[465.662854] Subtest test-time-stamp-atomic: SUCCESS (4.556s)
[466.825872] [070/133] (555s left) kms_busy (extended-pageflip-hang-newfb)
[466.932744] Starting subtest: extended-pageflip-hang-newfb
[466.935165] Starting dynamic subtest: pipe-A
[493.684056] Dynamic subtest pipe-A: SUCCESS (26.750s)
[493.693829] Starting dynamic subtest: pipe-D
[518.705660] Dynamic subtest pipe-D: SUCCESS (25.020s)
[518.708097] Subtest extended-pageflip-hang-newfb: SUCCESS (51.775s)
[519.580038] [071/133] (502s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[519.682946] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[519.687404] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[519.821248] [072/133] (502s left) i915_pm_sseu (full-enable)
[519.888858] Subtest full-enable: SKIP (0.000s)
[519.992631] [073/133] (502s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[520.098704] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[520.102648] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[520.226053] [074/133] (502s left) kms_vblank (query-busy)
[520.328779] Starting subtest: query-busy
[520.330935] Starting dynamic subtest: pipe-A-eDP-1
[522.234371] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.904s)
[522.247777] Starting dynamic subtest: pipe-D-eDP-1
[524.829375] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.593s)
[524.831578] Subtest query-busy: SUCCESS (4.501s)
[525.639429] [075/133] (496s left) kms_psr (fbc-psr2-primary-blt)
[525.731099] Starting subtest: fbc-psr2-primary-blt
[525.733349] Starting dynamic subtest: eDP-1
[525.737596] Dynamic subtest eDP-1: SKIP (0.000s)
[525.741900] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[525.813469] [076/133] (496s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[525.907479] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[525.911486] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[526.031887] [077/133] (496s left) gem_ctx_param (vm)
[526.091217] Starting subtest: vm
[526.137844] Subtest vm: SUCCESS (0.047s)
[526.304993] [078/133] (496s left) kms_big_fb (linear-64bpp-rotate-0)
[526.416160] Starting subtest: linear-64bpp-rotate-0
[527.904126] Subtest linear-64bpp-rotate-0: SUCCESS (1.489s)
[528.094446] [079/133] (494s left) gem_exec_parallel (engines)
[528.164606] Starting subtest: engines
[528.166977] Starting dynamic subtest: basic
[529.877035] Dynamic subtest basic: SUCCESS (1.710s)
[529.888874] Starting dynamic subtest: contexts
[534.275467] Dynamic subtest contexts: SUCCESS (4.396s)
[534.290828] Starting dynamic subtest: fds
[538.141483] Dynamic subtest fds: SUCCESS (3.864s)
[538.153129] Starting dynamic subtest: userptr
[539.949392] Dynamic subtest userptr: SUCCESS (1.806s)
[539.951749] Subtest engines: SUCCESS (11.784s)
[540.156514] [080/133] (482s left) perf (invalid-create-userspace-config)
[540.247950] Starting subtest: invalid-create-userspace-config
[540.250597] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[540.292232] [081/133] (482s left) gem_exec_balancer (individual)
[540.363987] Starting subtest: individual
[541.948597] Subtest individual: SUCCESS (1.582s)
[542.290589] [082/133] (480s left) api_intel_allocator (execbuf-with-allocator)
[542.352508] Starting subtest: execbuf-with-allocator
[542.364156] Subtest execbuf-with-allocator: SUCCESS (0.012s)
[542.520170] [083/133] (480s left) kms_cursor_edge_walk (64x64-top-edge)
[542.619277] Starting subtest: 64x64-top-edge
[542.621908] Starting dynamic subtest: pipe-A-eDP-1
[546.085968] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s)
[546.095424] Starting dynamic subtest: pipe-D-eDP-1
[549.205309] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[549.207594] Subtest 64x64-top-edge: SUCCESS (6.589s)
[550.029816] [084/133] (472s left) kms_psr (fbc-psr-cursor-plane-onoff)
[550.121273] Starting subtest: fbc-psr-cursor-plane-onoff
[550.123577] Starting dynamic subtest: eDP-1
[550.127652] Dynamic subtest eDP-1: SKIP (0.000s)
[550.131721] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[550.206361] [085/133] (472s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[550.314571] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[550.318578] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[550.432076] [086/133] (472s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[550.503310] Starting subtest: y-tiled-ccs-to-y-tiled
[550.507703] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[550.698576] [087/133] (472s left) gem_mmap_wc (close)
[550.759767] Subtest close: SKIP (0.000s)
[550.826950] [088/133] (472s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[550.923118] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[550.952414] Starting dynamic subtest: pipe-A-plane-0
[550.959080] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[550.969725] Starting dynamic subtest: pipe-A-plane-3
[550.974309] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[550.984113] Starting dynamic subtest: pipe-A-plane-5
[550.991080] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[552.104925] Starting dynamic subtest: pipe-B-plane-0
[552.109583] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[552.120422] Starting dynamic subtest: pipe-B-plane-3
[552.125017] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[552.133601] Starting dynamic subtest: pipe-B-plane-5
[552.138067] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[552.410133] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (1.487s)
[553.293749] [089/133] (469s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[553.400334] Starting subtest: x-tiled-16bpp-rotate-270
[553.419149] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s)
[553.568836] [090/133] (469s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[553.672157] Starting subtest: yf-tiled-addfb-size-offset-overflow
[553.676660] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[553.808349] [091/133] (469s left) sw_sync (sync_expired_merge)
[553.850255] Starting subtest: sync_expired_merge
[554.919892] Subtest sync_expired_merge: SUCCESS (1.074s)
[554.995363] [092/133] (468s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[555.091576] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[555.095981] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[555.168919] [093/133] (468s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[555.283848] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[562.260958] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.981s)
[562.441199] [094/133] (460s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[562.538218] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[562.540525] Starting dynamic subtest: pipe-A-eDP-1
[568.390670] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.856s)
[568.399488] Starting dynamic subtest: pipe-B-eDP-1
[574.968409] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.576s)
[574.970826] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.435s)
[575.857599] [095/133] (447s left) gem_create (create-ext-cpu-access-big)
[576.034795] Starting subtest: create-ext-cpu-access-big
[576.039528] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[576.118563] [096/133] (447s left) gem_ctx_persistence (saturated-hostile)
[576.183325] Starting subtest: saturated-hostile
[576.185647] Starting dynamic subtest: rcs0
[577.046459] Dynamic subtest rcs0: SUCCESS (0.863s)
[577.058724] Starting dynamic subtest: bcs0
[577.858901] Dynamic subtest bcs0: SUCCESS (0.810s)
[577.869715] Starting dynamic subtest: vcs0
[578.670536] Dynamic subtest vcs0: SUCCESS (0.810s)
[578.682671] Starting dynamic subtest: vcs1
[579.485823] Dynamic subtest vcs1: SUCCESS (0.813s)
[579.497313] Starting dynamic subtest: vecs0
[580.289094] Dynamic subtest vecs0: SUCCESS (0.802s)
[580.300776] Starting dynamic subtest: ccs0
[581.148932] Dynamic subtest ccs0: SUCCESS (0.859s)
[581.151390] Subtest saturated-hostile: SUCCESS (4.967s)
[581.247405] [097/133] (442s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[581.316067] Starting subtest: wait-all-for-submit-delayed-submit
[581.420560] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[581.511339] [098/133] (441s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[581.622106] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[581.626413] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[581.730417] [099/133] (441s left) kms_content_protection (atomic-hdcp14)
[581.865798] Starting subtest: atomic-hdcp14
[581.870380] Subtest atomic-hdcp14: SKIP (0.000s)
[582.018509] [100/133] (441s left) gem_tiled_blits (normal)
[582.081197] Subtest normal: SKIP (0.000s)
[582.180705] [101/133] (441s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[582.276649] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[582.280922] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[582.370274] [102/133] (441s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[582.469472] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[582.472949] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[582.580999] [103/133] (441s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[582.664102] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[582.666026] Starting dynamic subtest: pipe-A-eDP-1
[583.909112] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.245s)
[583.918783] Starting dynamic subtest: pipe-B-eDP-1
[586.143724] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.233s)
[586.153146] Starting dynamic subtest: pipe-C-eDP-1
[588.375155] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.230s)
[588.384829] Starting dynamic subtest: pipe-D-eDP-1
[590.632796] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.256s)
[590.635099] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (7.969s)
[591.784367] [104/133] (431s left) gem_exec_schedule (implicit-write-read)
[591.859532] Starting subtest: implicit-write-read
[591.861465] Starting dynamic subtest: rcs0
[591.954541] Dynamic subtest rcs0: SUCCESS (0.103s)
[591.966411] Starting dynamic subtest: vcs0
[592.033175] Dynamic subtest vcs0: SUCCESS (0.079s)
[592.044770] Starting dynamic subtest: vcs1
[592.109880] Dynamic subtest vcs1: SUCCESS (0.076s)
[592.121414] Starting dynamic subtest: vecs0
[592.186457] Dynamic subtest vecs0: SUCCESS (0.076s)
[592.198499] Starting dynamic subtest: ccs0
[592.277048] Dynamic subtest ccs0: SUCCESS (0.089s)
[592.279719] Subtest implicit-write-read: SUCCESS (0.427s)
[594.072228] [105/133] (429s left) core_auth (getclient-simple)
[594.108202] Starting subtest: getclient-simple
[594.134088] Subtest getclient-simple: SUCCESS (0.025s)
[594.283831] [106/133] (429s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[594.383711] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[595.018510] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.636s)
[595.206392] [107/133] (428s left) i915_drm_fdinfo (basics)
[595.251776] Starting subtest: basics
[595.254067] Subtest basics: SUCCESS (0.000s)
[595.325258] [108/133] (428s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[595.433310] Starting subtest: fbcpsr-rgb101010-draw-blt
[602.193863] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.763s)
[602.362711] [109/133] (421s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[602.481300] Starting subtest: short-flip-before-cursor-toggle
[603.401442] Subtest short-flip-before-cursor-toggle: SUCCESS (0.919s)
[604.233334] [110/133] (419s left) kms_color (invalid-degamma-lut-sizes)
[604.335979] Starting subtest: invalid-degamma-lut-sizes
[604.338253] Starting dynamic subtest: pipe-A
[604.620946] Dynamic subtest pipe-A: SUCCESS (0.285s)
[604.635852] Starting dynamic subtest: pipe-B
[604.638660] Dynamic subtest pipe-B: SUCCESS (0.000s)
[604.649948] Starting dynamic subtest: pipe-C
[604.652321] Dynamic subtest pipe-C: SUCCESS (0.000s)
[604.660633] Starting dynamic subtest: pipe-D
[604.662918] Dynamic subtest pipe-D: SUCCESS (0.000s)
[604.665154] Subtest invalid-degamma-lut-sizes: SUCCESS (0.288s)
[605.470135] [111/133] (418s left) kms_invalid_mode (bad-vsync-start)
[605.571480] Starting subtest: bad-vsync-start
[605.573817] Starting dynamic subtest: pipe-A-eDP-1
[605.858933] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[605.868261] Starting dynamic subtest: pipe-B-eDP-1
[605.870450] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[605.878895] Starting dynamic subtest: pipe-C-eDP-1
[605.881094] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[605.889657] Starting dynamic subtest: pipe-D-eDP-1
[605.891771] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[605.893948] Subtest bad-vsync-start: SUCCESS (0.295s)
[606.701303] [112/133] (417s left) kms_vblank (wait-forked)
[606.787953] Starting subtest: wait-forked
[606.790240] Starting dynamic subtest: pipe-A-eDP-1
[608.600850] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[608.615676] Starting dynamic subtest: pipe-D-eDP-1
[611.065621] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.463s)
[611.068077] Subtest wait-forked: SUCCESS (4.279s)
[611.973186] [113/133] (412s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[612.084920] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[612.089060] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[612.220363] [114/133] (411s left) kms_fence_pin_leak
[612.411490] [115/133] (411s left) gem_userptr_blits (usage-restrictions)
[612.472809] Starting subtest: usage-restrictions
[612.474797] Subtest usage-restrictions: SUCCESS (0.000s)
[612.596137] [116/133] (411s left) kms_lease (lease-unleased-crtc)
[612.688313] Starting subtest: lease-unleased-crtc
[612.690513] Starting dynamic subtest: pipe-A-eDP-1
[612.981653] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[612.991716] Starting dynamic subtest: pipe-B-eDP-1
[613.707724] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.724s)
[613.718686] Starting dynamic subtest: pipe-C-eDP-1
[613.721089] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[613.734389] Starting dynamic subtest: pipe-D-eDP-1
[613.736712] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[613.739058] Subtest lease-unleased-crtc: SUCCESS (1.032s)
[614.098959] [117/133] (410s left) gem_caching (writes)
[614.164456] Subtest writes: SKIP (0.000s)
[614.245338] [118/133] (410s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[614.349640] Starting subtest: pr-overlay-plane-update-continuous-sf
[614.353607] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[614.428766] [119/133] (409s left) kms_flip (2x-plain-flip-fb-recreate)
[614.517374] Starting subtest: 2x-plain-flip-fb-recreate
[614.526839] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[614.617933] [120/133] (409s left) gem_tiled_partial_pwrite_pread (reads)
[614.688373] Subtest reads: SKIP (0.000s)
[614.778427] [121/133] (409s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[614.872584] Starting subtest: psr-indfb-scaledprimary
[620.657450] Subtest psr-indfb-scaledprimary: SUCCESS (5.786s)
[620.805349] [122/133] (403s left) syncobj_timeline (multi-wait-available-signaled)
[620.854117] Starting subtest: multi-wait-available-signaled
[620.856430] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[620.975049] [123/133] (403s left) gem_exec_reloc (basic-cpu-gtt)
[621.038791] Subtest basic-cpu-gtt: SKIP (0.000s)
[621.131925] [124/133] (403s left) gem_shrink (reclaim)
[621.191270] Starting subtest: reclaim
[623.708182] Subtest reclaim: SUCCESS (2.517s)
[623.821030] [125/133] (400s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[623.948707] Starting subtest: fbc-rgb101010-draw-blt
[628.509215] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.562s)
[629.710382] [126/133] (394s left) gem_ctx_sseu (engines)
[629.777369] Subtest engines: SKIP (0.000s)
[629.853631] [127/133] (394s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[629.903140] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[630.010246] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[630.114883] [128/133] (394s left) gen9_exec_parse (bb-start-far)
[630.168717] Subtest bb-start-far: SKIP (0.000s)
[630.251444] [129/133] (394s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[630.351694] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[630.353780] Starting dynamic subtest: pipe-A-eDP-1
[632.388285] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.037s)
[632.396715] Starting dynamic subtest: pipe-B-eDP-1
[634.467051] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.077s)
[634.475924] Starting dynamic subtest: pipe-C-eDP-1
[636.522888] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.055s)
[636.532725] Starting dynamic subtest: pipe-D-eDP-1
[638.717501] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.194s)
[638.719349] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.369s)
[639.921494] [130/133] (384s left) prime_vgem (sync)
[640.014400] Starting subtest: sync
[640.016788] Starting dynamic subtest: rcs0
[640.096216] Dynamic subtest rcs0: SUCCESS (0.082s)
[640.106074] Starting dynamic subtest: bcs0
[640.203454] Dynamic subtest bcs0: SUCCESS (0.106s)
[640.213059] Starting dynamic subtest: vcs0
[640.252239] Dynamic subtest vcs0: SUCCESS (0.048s)
[640.263017] Starting dynamic subtest: vcs1
[640.298835] Dynamic subtest vcs1: SUCCESS (0.046s)
[640.308441] Starting dynamic subtest: vecs0
[640.345022] Dynamic subtest vecs0: SUCCESS (0.045s)
[640.354313] Starting dynamic subtest: ccs0
[640.389055] Dynamic subtest ccs0: SUCCESS (0.043s)
[640.391376] Subtest sync: SUCCESS (0.376s)
[640.521274] [131/133] (384s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[642.034917] Starting subtest: gem-execbuf-stress-pc8
[642.073265] Subtest gem-execbuf-stress-pc8: SKIP (0.037s)
[642.757787] [132/133] (382s left) kms_cursor_crc (cursor-onscreen-128x128)
[642.982057] Starting subtest: cursor-onscreen-128x128
[642.984366] Starting dynamic subtest: pipe-A-eDP-1
[645.103200] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.118s)
[645.143795] Starting dynamic subtest: pipe-D-eDP-1
[647.924177] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.787s)
[647.926463] Subtest cursor-onscreen-128x128: SUCCESS (4.944s)
[648.795157] [133/133] (376s left) kms_psr (psr2-sprite-blt)
[648.892260] Starting subtest: psr2-sprite-blt
[648.894402] Starting dynamic subtest: eDP-1
[650.585361] Dynamic subtest eDP-1: SUCCESS (1.694s)
[650.587839] Subtest psr2-sprite-blt: SUCCESS (1.696s)
[651.461512] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: gem_ccs
results: parsing output: 4/ for test: i915_query
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_rotation_crc
results: parsing output: 7/ for test: kms_vrr
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_sync
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_atomic_interruptible
results: parsing output: 13/ for test: gem_pxp
results: parsing output: 14/ for test: kms_pm_dc
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: kms_pm_rpm
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: gem_exec_whisper
results: parsing output: 25/ for test: kms_multipipe_modeset
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: gem_wait
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: gem_mmap_offset
results: parsing output: 32/ for test: core_getversion
results: parsing output: 33/ for test: gem_exec_whisper
results: parsing output: 34/ for test: kms_feature_discovery
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_mmap_wc
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: i915_hangman
results: parsing output: 40/ for test: syncobj_basic
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_chamelium_edid
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_exec_capture
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_softpin
results: parsing output: 51/ for test: kms_chamelium_hpd
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: gem_partial_pwrite_pread
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: kms_async_flips
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: vgem_basic
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_properties
results: parsing output: 67/ for test: sysfs_heartbeat_interval
results: parsing output: 68/ for test: kms_async_flips
results: parsing output: 69/ for test: kms_busy
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: i915_pm_sseu
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_ctx_param
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_parallel
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: gem_exec_balancer
results: parsing output: 81/ for test: api_intel_allocator
results: parsing output: 82/ for test: kms_cursor_edge_walk
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: gem_mmap_wc
results: parsing output: 87/ for test: kms_plane
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: sw_sync
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: gem_create
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_content_protection
results: parsing output: 99/ for test: gem_tiled_blits
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: core_auth
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_color
results: parsing output: 110/ for test: kms_invalid_mode
results: parsing output: 111/ for test: kms_vblank
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_fence_pin_leak
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: kms_lease
results: parsing output: 116/ for test: gem_caching
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: gem_shrink
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_ctx_sseu
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gen9_exec_parse
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: prime_vgem
results: parsing output: 130/ for test: i915_pm_rpm
results: parsing output: 131/ for test: kms_cursor_crc
results: parsing output: 132/ for test: kms_psr
Done.