[56.982965] Initializing watchdogs
[56.983034]   /dev/watchdog0
[56.997382] [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]
[57.001871] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.004518] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.007849] [001/133] (960s left) i915_drm_fdinfo (memory-info-shared)
[57.074734] Starting subtest: memory-info-shared
[57.077115] Starting dynamic subtest: smem0
[57.119307] Dynamic subtest smem0: SUCCESS (0.044s)
[57.121785] Subtest memory-info-shared: SUCCESS (0.045s)
[57.203671] [002/133] (960s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[57.319528] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[57.358448] Starting dynamic subtest: pipe-A-plane-0
[57.791638] Dynamic subtest pipe-A-plane-0: SUCCESS (0.434s)
[57.799586] Starting dynamic subtest: pipe-A-plane-3
[58.046613] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s)
[58.053508] Starting dynamic subtest: pipe-A-plane-5
[58.057132] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[59.130807] Starting dynamic subtest: pipe-B-plane-0
[59.556891] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[59.565465] Starting dynamic subtest: pipe-B-plane-3
[59.823864] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[59.831019] Starting dynamic subtest: pipe-B-plane-5
[59.835146] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[60.131563] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.813s)
[61.000957] [003/133] (956s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[61.099721] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[61.104082] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[61.171572] [004/133] (956s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[61.252828] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[61.255107] Starting dynamic subtest: pipe-A-eDP-1
[61.544620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.260s)
[61.553413] Starting dynamic subtest: pipe-B-eDP-1
[62.802925] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.258s)
[62.811862] Starting dynamic subtest: pipe-C-eDP-1
[64.082710] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.278s)
[64.091793] Starting dynamic subtest: pipe-D-eDP-1
[65.322025] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[65.324375] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.040s)
[66.439310] [005/133] (951s left) fbdev (info)
[66.481688] Starting subtest: info
[66.483686] Subtest info: SUCCESS (0.000s)
[66.547041] [006/133] (951s left) prime_vgem (coherency-blt)
[66.677308] Starting subtest: coherency-blt
[68.192635] Subtest coherency-blt: SUCCESS (1.514s)
[68.326870] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[68.330182] [007/133] (949s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[68.423311] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[68.425674] Starting dynamic subtest: pipe-A-eDP-1
[68.449338] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.459561] Starting dynamic subtest: pipe-B-eDP-1
[68.482025] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.489143] Starting dynamic subtest: pipe-C-eDP-1
[68.511218] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.518286] Starting dynamic subtest: pipe-D-eDP-1
[68.541303] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.545349] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[70.706191] [008/133] (947s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[70.759692] Starting subtest: invalid-single-wait-all-unsubmitted
[70.761996] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[70.855961] [009/133] (946s left) api_intel_bb (simple-bb)
[70.918761] Starting subtest: simple-bb
[70.923365] Subtest simple-bb: SUCCESS (0.006s)
[71.051948] [010/133] (946s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[71.141256] Starting subtest: multiplane-rotation-cropping-bottom
[88.567057] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.427s)
[88.688373] [011/133] (929s left) kms_plane_multiple (tiling-4)
[88.790210] Starting subtest: tiling-4
[88.792164] Starting dynamic subtest: pipe-A-eDP-1
[92.571923] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.780s)
[92.582097] Starting dynamic subtest: pipe-B-eDP-1
[97.081061] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.509s)
[97.089177] Starting dynamic subtest: pipe-C-eDP-1
[101.434654] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.351s)
[101.442909] Starting dynamic subtest: pipe-D-eDP-1
[105.756579] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.322s)
[105.758906] Subtest tiling-4: SUCCESS (16.966s)
[106.565595] [012/133] (911s left) kms_content_protection (atomic-dpms-hdcp14)
[106.706078] Starting subtest: atomic-dpms-hdcp14
[106.710853] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[106.824948] [013/133] (911s left) i915_pciid
[107.000024] [014/133] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[107.092291] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[107.096566] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[107.204685] [015/133] (910s left) gem_ctx_isolation (preservation-reset)
[107.373993] Starting subtest: preservation-reset
[107.376759] Starting dynamic subtest: rcs0
[107.661600] Dynamic subtest rcs0: SUCCESS (0.288s)
[107.672069] Starting dynamic subtest: bcs0
[107.990984] Dynamic subtest bcs0: SUCCESS (0.329s)
[107.999075] Starting dynamic subtest: vcs0
[108.316315] Dynamic subtest vcs0: SUCCESS (0.324s)
[108.325439] Starting dynamic subtest: vcs1
[110.223109] Dynamic subtest vcs1: SUCCESS (1.906s)
[110.231089] Starting dynamic subtest: vecs0
[112.197314] Dynamic subtest vecs0: SUCCESS (1.973s)
[112.207889] Starting dynamic subtest: ccs0
[114.195881] Dynamic subtest ccs0: SUCCESS (1.998s)
[114.198259] Subtest preservation-reset: SUCCESS (6.825s)
[114.330837] [016/133] (903s left) syncobj_wait (invalid-reset-bad-pad)
[114.383417] Starting subtest: invalid-reset-bad-pad
[114.385681] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[114.491156] [017/133] (903s left) gem_mmap_wc (set-cache-level)
[114.550630] Subtest set-cache-level: SKIP (0.000s)
[114.612302] [018/133] (903s left) kms_invalid_mode (uint-max-clock)
[114.702910] Starting subtest: uint-max-clock
[114.705206] Starting dynamic subtest: pipe-A-eDP-1
[114.997367] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[115.005404] Starting dynamic subtest: pipe-B-eDP-1
[115.007251] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[115.014129] Starting dynamic subtest: pipe-C-eDP-1
[115.016021] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[115.023447] Starting dynamic subtest: pipe-D-eDP-1
[115.025602] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[115.027724] Subtest uint-max-clock: SUCCESS (0.302s)
[115.800355] [019/133] (902s left) perf_pmu (busy-no-semaphores)
[115.841663] Starting subtest: busy-no-semaphores
[115.843902] Starting dynamic subtest: rcs0
[116.403662] Dynamic subtest rcs0: SUCCESS (0.562s)
[116.413841] Starting dynamic subtest: bcs0
[116.954810] Dynamic subtest bcs0: SUCCESS (0.548s)
[116.965805] Starting dynamic subtest: vcs0
[117.507041] Dynamic subtest vcs0: SUCCESS (0.549s)
[117.517890] Starting dynamic subtest: vcs1
[119.449854] Dynamic subtest vcs1: SUCCESS (1.940s)
[119.460038] Starting dynamic subtest: vecs0
[121.435277] Dynamic subtest vecs0: SUCCESS (1.983s)
[121.445647] Starting dynamic subtest: ccs0
[123.418447] Dynamic subtest ccs0: SUCCESS (1.980s)
[123.421170] Subtest busy-no-semaphores: SUCCESS (7.579s)
[123.534546] [020/133] (894s left) gem_spin_batch (engines)
[123.603564] Starting subtest: engines
[123.605922] Starting dynamic subtest: rcs0
[126.849408] Dynamic subtest rcs0: SUCCESS (3.241s)
[126.859401] Starting dynamic subtest: bcs0
[130.086652] Dynamic subtest bcs0: SUCCESS (3.235s)
[130.096704] Starting dynamic subtest: vcs0
[133.322090] Dynamic subtest vcs0: SUCCESS (3.233s)
[133.332081] Starting dynamic subtest: vcs1
[136.559975] Dynamic subtest vcs1: SUCCESS (3.234s)
[136.568226] Starting dynamic subtest: vecs0
[139.795740] Dynamic subtest vecs0: SUCCESS (3.233s)
[139.804070] Starting dynamic subtest: ccs0
[143.028045] Dynamic subtest ccs0: SUCCESS (3.230s)
[143.030426] Subtest engines: SUCCESS (19.421s)
[143.264725] [021/133] (875s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[143.375702] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[143.380146] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[143.463838] [022/133] (874s left) kms_chamelium_color (gamma)
[143.551328] Subtest gamma: SKIP (0.000s)
[143.599098] [023/133] (874s left) i915_pm_rpm (gem-execbuf-stress)
[145.149992] Starting subtest: gem-execbuf-stress
[145.152639] Starting dynamic subtest: smem0
[158.072818] Dynamic subtest smem0: SUCCESS (12.924s)
[158.083653] Starting dynamic subtest: extra-wait-smem0
[219.852131] Dynamic subtest extra-wait-smem0: SUCCESS (61.774s)
[219.854893] Subtest gem-execbuf-stress: SUCCESS (74.704s)
[220.244140] [024/133] (798s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[220.371470] Starting subtest: flip-vs-cursor-crc-atomic
[221.075533] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.703s)
[221.952683] [025/133] (796s left) gem_mmap_offset (partial-mmap)
[222.021897] Starting subtest: partial-mmap
[222.024134] Starting dynamic subtest: smem0
[222.026265] Dynamic subtest smem0: SUCCESS (0.003s)
[222.028095] Subtest partial-mmap: SUCCESS (0.003s)
[222.165076] [026/133] (796s left) gem_exec_reloc (basic-wc-read-active)
[222.229720] Subtest basic-wc-read-active: SKIP (0.000s)
[222.304176] [027/133] (796s left) prime_self_import (basic-with_two_bos)
[222.345474] Starting subtest: basic-with_two_bos
[222.353439] Subtest basic-with_two_bos: SUCCESS (0.014s)
[222.452544] [028/133] (796s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[222.549261] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[222.551177] Starting dynamic subtest: pipe-A-eDP-1
[223.406935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.850s)
[223.416166] Starting dynamic subtest: pipe-B-eDP-1
[225.068376] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.658s)
[225.078134] Starting dynamic subtest: pipe-C-eDP-1
[226.608328] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.541s)
[226.617427] Starting dynamic subtest: pipe-D-eDP-1
[228.146257] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.537s)
[228.148703] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.590s)
[229.354716] [029/133] (789s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[229.462374] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[230.298466] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[230.497210] [030/133] (788s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[230.597086] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[230.601181] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[230.706191] [031/133] (788s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[230.767575] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[230.770065] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[230.877994] [032/133] (787s left) gem_linear_blits (normal)
[231.242314] Starting subtest: normal
[235.153648] Subtest normal: SUCCESS (3.913s)
[235.376802] [033/133] (783s left) gen7_exec_parse (basic-offset)
[235.469781] Subtest basic-offset: SKIP (0.000s)
[235.551095] [034/133] (783s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[235.660596] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[235.665157] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[235.725785] [035/133] (783s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[236.315857] Starting subtest: syncobj-backward-timeline-chain-engines
[236.520357] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.205s)
[238.009214] [036/133] (780s left) kms_vrr (flip-basic)
[238.103207] Starting subtest: flip-basic
[238.109948] Subtest flip-basic: SKIP (0.000s)
[238.176917] [037/133] (780s left) gem_exec_params (readonly)
[238.236212] Starting subtest: readonly
[238.241219] Subtest readonly: SUCCESS (0.003s)
[238.343564] [038/133] (780s left) syncobj_timeline (single-wait-for-submit-signaled)
[238.412765] Starting subtest: single-wait-for-submit-signaled
[238.415077] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[238.522974] [039/133] (780s left) gem_lmem_swapping (basic)
[238.572457] Subtest basic: SKIP (0.000s)
[238.619030] [040/133] (780s left) gem_exec_balancer (hang)
[238.894978] Starting subtest: hang
[240.917525] Subtest hang: SUCCESS (2.025s)
[241.031716] [041/133] (778s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[241.145791] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[241.150279] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[241.249813] [042/133] (777s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[241.380901] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[241.385528] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[241.527952] [043/133] (777s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[241.621286] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[248.734776] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.116s)
[248.873357] [044/133] (770s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[248.971664] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[248.975750] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[249.074269] [045/133] (770s left) gem_exec_endless (dispatch)
[249.139469] Starting subtest: dispatch
[249.141866] Starting dynamic subtest: rcs0
[249.148556] Dynamic subtest rcs0: SUCCESS (0.005s)
[249.158239] Starting dynamic subtest: bcs0
[249.162821] Dynamic subtest bcs0: SUCCESS (0.004s)
[249.172296] Starting dynamic subtest: vcs0
[249.176805] Dynamic subtest vcs0: SUCCESS (0.004s)
[249.186847] Starting dynamic subtest: vcs1
[249.190969] Dynamic subtest vcs1: SUCCESS (0.004s)
[249.199217] Starting dynamic subtest: vecs0
[249.203466] Dynamic subtest vecs0: SUCCESS (0.006s)
[249.211700] Starting dynamic subtest: ccs0
[249.215785] Dynamic subtest ccs0: SUCCESS (0.008s)
[249.217707] Subtest dispatch: SUCCESS (0.037s)
[250.960300] [046/133] (768s left) perf (gen12-invalid-class-instance)
[251.105399] Starting subtest: gen12-invalid-class-instance
[251.116061] Subtest gen12-invalid-class-instance: SUCCESS (0.011s)
[251.157486] [047/133] (768s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[251.212049] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[251.214319] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[251.322072] [048/133] (768s left) api_intel_bb (blit-reloc-purge-cache)
[251.377090] Starting subtest: blit-reloc-purge-cache
[251.381350] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[251.479757] [049/133] (768s left) gem_madvise (dontneed-after-mmap)
[251.519400] Starting subtest: dontneed-after-mmap
[251.541583] Subtest dontneed-after-mmap: SUCCESS (0.021s)
[251.674050] [050/133] (767s left) gem_tiled_fence_blits (normal)
[251.740230] Subtest normal: SKIP (0.000s)
[251.793322] [051/133] (767s left) kms_flip (flip-vs-panning)
[251.894214] Starting subtest: flip-vs-panning
[251.896153] Starting dynamic subtest: A-eDP1
[260.605492] Dynamic subtest A-eDP1: SUCCESS (8.713s)
[260.616954] Starting dynamic subtest: B-eDP1
[269.339764] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[269.351123] Starting dynamic subtest: C-eDP1
[278.063972] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[278.077582] Starting dynamic subtest: D-eDP1
[286.783423] Dynamic subtest D-eDP1: SUCCESS (8.717s)
[286.787573] Subtest flip-vs-panning: SUCCESS (34.894s)
[287.939810] [052/133] (731s left) kms_draw_crc (draw-method-render)
[288.037380] Starting subtest: draw-method-render
[288.039525] Starting dynamic subtest: xrgb8888-untiled
[288.289994] Dynamic subtest xrgb8888-untiled: SUCCESS (0.254s)
[288.299416] Starting dynamic subtest: rgb565-untiled
[288.545287] Dynamic subtest rgb565-untiled: SUCCESS (0.253s)
[288.554116] Starting dynamic subtest: xrgb2101010-untiled
[288.778664] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[288.787985] Starting dynamic subtest: xbgr16161616f-untiled
[289.022852] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[289.039400] Starting dynamic subtest: xrgb8888-xtiled
[289.156150] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[289.170974] Starting dynamic subtest: rgb565-xtiled
[289.278551] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[289.287635] Starting dynamic subtest: xrgb2101010-xtiled
[289.401037] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[289.417754] Starting dynamic subtest: xbgr16161616f-xtiled
[289.533918] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[289.542832] Starting dynamic subtest: xrgb8888-4tiled
[289.667394] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[289.676773] Starting dynamic subtest: rgb565-4tiled
[289.789612] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[289.800654] Starting dynamic subtest: xrgb2101010-4tiled
[289.911801] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.120s)
[289.923294] Starting dynamic subtest: xbgr16161616f-4tiled
[290.045168] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s)
[290.047057] Subtest draw-method-render: SUCCESS (2.012s)
[290.129089] [053/133] (729s left) kms_atomic_interruptible (universal-setplane-primary)
[290.219262] Starting subtest: universal-setplane-primary
[290.221282] Starting dynamic subtest: pipe-A-eDP-1
[297.672274] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.449s)
[297.674660] Subtest universal-setplane-primary: SUCCESS (7.451s)
[298.536799] [054/133] (721s left) gem_exec_schedule (u-fairslice)
[298.605156] Starting subtest: u-fairslice
[298.607123] Starting dynamic subtest: rcs0
[300.618890] Dynamic subtest rcs0: SUCCESS (2.019s)
[300.629367] Starting dynamic subtest: bcs0
[302.640634] Dynamic subtest bcs0: SUCCESS (2.019s)
[302.650575] Starting dynamic subtest: vcs0
[304.657489] Dynamic subtest vcs0: SUCCESS (2.018s)
[304.667438] Starting dynamic subtest: vcs1
[306.677653] Dynamic subtest vcs1: SUCCESS (2.019s)
[306.687734] Starting dynamic subtest: vecs0
[308.700804] Dynamic subtest vecs0: SUCCESS (2.018s)
[308.711361] Starting dynamic subtest: ccs0
[310.721702] Dynamic subtest ccs0: SUCCESS (2.024s)
[310.723856] Subtest u-fairslice: SUCCESS (12.122s)
[311.019281] [055/133] (708s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[311.129745] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[311.133788] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[311.232973] [056/133] (708s left) i915_query (query-topology-kernel-writes)
[311.287117] Starting subtest: query-topology-kernel-writes
[311.289236] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[311.380277] [057/133] (708s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[311.488510] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[311.492887] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[311.589961] [058/133] (708s left) gem_mmap_gtt (basic-small-bo)
[311.661574] Subtest basic-small-bo: SKIP (0.000s)
[311.726108] [059/133] (708s left) gem_exec_params (invalid-flag)
[311.774435] Starting subtest: invalid-flag
[311.776770] Subtest invalid-flag: SUCCESS (0.000s)
[311.888765] [060/133] (708s left) gem_exec_async (forked-writes)
[311.952092] Starting subtest: forked-writes
[311.954369] Starting dynamic subtest: rcs0
[311.979561] Dynamic subtest rcs0: SUCCESS (0.027s)
[311.990562] Starting dynamic subtest: bcs0
[312.003562] Dynamic subtest bcs0: SUCCESS (0.023s)
[312.012593] Starting dynamic subtest: vcs0
[312.026617] Dynamic subtest vcs0: SUCCESS (0.022s)
[312.036340] Starting dynamic subtest: vcs1
[312.050465] Dynamic subtest vcs1: SUCCESS (0.023s)
[312.061832] Starting dynamic subtest: vecs0
[312.073830] Dynamic subtest vecs0: SUCCESS (0.022s)
[312.082519] Starting dynamic subtest: ccs0
[312.097895] Dynamic subtest ccs0: SUCCESS (0.023s)
[312.099816] Subtest forked-writes: SUCCESS (0.146s)
[312.340929] [061/133] (707s left) gem_tiled_pread_basic (basic)
[312.389584] Subtest basic: SKIP (0.000s)
[312.453009] [062/133] (707s left) kms_cursor_crc (cursor-random-32x10)
[312.616916] Starting subtest: cursor-random-32x10
[312.668287] Subtest cursor-random-32x10: SKIP (0.045s)
[312.956736] [063/133] (707s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[313.048859] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[320.378738] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.333s)
[320.491506] [064/133] (699s left) gem_exec_nop (basic-series)
[320.571270] Starting subtest: basic-series
[336.923497] Subtest basic-series: SUCCESS (16.358s)
[337.153973] [065/133] (683s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[337.265580] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[337.269906] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[337.373769] [066/133] (682s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[337.430808] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[337.496411] [067/133] (682s left) gem_eio (wait-1us)
[337.739942] Starting subtest: wait-1us
[338.133571] Subtest wait-1us: SUCCESS (0.396s)
[338.252225] [068/133] (682s left) sysfs_timeslice_duration (duration)
[338.306711] Starting subtest: duration
[338.308590] Starting dynamic subtest: vecs0
[351.860446] Dynamic subtest vecs0: SUCCESS (13.550s)
[351.873439] Starting dynamic subtest: ccs0
[365.004087] Dynamic subtest ccs0: SUCCESS (13.142s)
[365.015838] Starting dynamic subtest: vcs0
[378.805065] Dynamic subtest vcs0: SUCCESS (13.796s)
[378.816775] Starting dynamic subtest: bcs0
[391.959993] Dynamic subtest bcs0: SUCCESS (13.153s)
[391.972328] Starting dynamic subtest: rcs0
[405.118640] Dynamic subtest rcs0: SUCCESS (13.155s)
[405.131063] Starting dynamic subtest: vcs1
[418.805041] Dynamic subtest vcs1: SUCCESS (13.682s)
[418.808030] Subtest duration: SUCCESS (80.495s)
[418.883106] [069/133] (601s left) gem_fenced_exec_thrash (too-many-fences)
[418.958249] Subtest too-many-fences: SKIP (0.000s)
[419.021902] [070/133] (601s left) gem_eio (wait-wedge-10ms)
[419.205212] Starting subtest: wait-wedge-10ms
[420.945993] Subtest wait-wedge-10ms: SUCCESS (1.741s)
[421.094751] [071/133] (599s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[421.196239] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[421.200488] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[421.349641] [072/133] (599s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[421.451047] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[428.161526] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.712s)
[428.301670] [073/133] (592s left) i915_selftest (mock)
[431.698104] Starting subtest: mock
[431.701657] Starting dynamic subtest: sanitycheck
[432.377234] Dynamic subtest sanitycheck: SUCCESS (0.683s)
[432.387451] Starting dynamic subtest: shmem
[433.032093] Dynamic subtest shmem: SUCCESS (0.653s)
[433.042409] Starting dynamic subtest: fence
[441.056712] Dynamic subtest fence: SUCCESS (8.022s)
[441.066097] Starting dynamic subtest: scatterlist
[442.725513] Dynamic subtest scatterlist: SUCCESS (1.667s)
[442.738880] Starting dynamic subtest: syncmap
[446.142077] Dynamic subtest syncmap: SUCCESS (3.413s)
[446.157328] Starting dynamic subtest: uncore
[446.827220] Dynamic subtest uncore: SUCCESS (0.683s)
[446.836608] Starting dynamic subtest: ring
[447.510218] Dynamic subtest ring: SUCCESS (0.681s)
[447.519650] Starting dynamic subtest: engine
[448.197907] Dynamic subtest engine: SUCCESS (0.686s)
[448.207755] Starting dynamic subtest: timelines
[452.020036] Dynamic subtest timelines: SUCCESS (3.819s)
[452.030057] Starting dynamic subtest: requests
[455.371933] Dynamic subtest requests: SUCCESS (3.350s)
[455.386075] Starting dynamic subtest: objects
[456.133209] Dynamic subtest objects: SUCCESS (0.761s)
[456.142586] Starting dynamic subtest: phys
[456.933519] Dynamic subtest phys: SUCCESS (0.798s)
[456.942953] Starting dynamic subtest: dmabuf
[457.688460] Dynamic subtest dmabuf: SUCCESS (0.754s)
[457.696488] Starting dynamic subtest: vma
[463.426205] Dynamic subtest vma: SUCCESS (5.734s)
[463.434557] Starting dynamic subtest: evict
[464.890582] Dynamic subtest evict: SUCCESS (1.464s)
[464.905520] Starting dynamic subtest: gtt
[468.231205] Dynamic subtest gtt: SUCCESS (3.338s)
[468.243844] Starting dynamic subtest: hugepages
[469.114229] Dynamic subtest hugepages: SUCCESS (0.881s)
[469.123741] Starting dynamic subtest: memory_region
[471.699152] Dynamic subtest memory_region: SUCCESS (2.583s)
[471.701985] Subtest mock: SUCCESS (40.005s)
[471.729454] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[471.730204] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[471.733368] [074/133] (548s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[473.335679] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[473.339932] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[473.428987] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[473.430314] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)] new: kernel.kmod_is_loaded.i915: true
[473.434070] [075/133] (547s left) gem_pxp (display-protected-crc)
[473.563792] Starting subtest: display-protected-crc
[475.275104] Subtest display-protected-crc: SUCCESS (1.713s)
[475.383187] [076/133] (545s left) gem_exec_params (invalid-ring2)
[475.436447] Starting subtest: invalid-ring2
[475.438640] Subtest invalid-ring2: SUCCESS (0.000s)
[475.538099] [077/133] (545s left) kms_psr (fbc-pr-cursor-render)
[475.622157] Starting subtest: fbc-pr-cursor-render
[475.626508] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[475.692263] [078/133] (545s left) gem_ctx_shared (create-shared-gtt)
[475.764880] Starting subtest: create-shared-gtt
[477.917988] Subtest create-shared-gtt: SUCCESS (2.154s)
[478.327082] [079/133] (542s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[478.414793] Starting subtest: primary-y-tiled-reflect-x-270
[478.419069] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[478.499891] [080/133] (542s left) kms_psr (fbc-psr-sprite-plane-onoff)
[478.581853] Starting subtest: fbc-psr-sprite-plane-onoff
[478.584110] Starting dynamic subtest: eDP-1
[478.588120] Dynamic subtest eDP-1: SKIP (0.000s)
[478.592157] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[478.653566] [081/133] (542s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[478.745545] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[482.347898] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.606s)
[483.546299] [082/133] (537s left) gem_ctx_engines (execute-oneforall)
[483.615750] Starting subtest: execute-oneforall
[484.138716] Subtest execute-oneforall: SUCCESS (0.526s)
[484.993693] [083/133] (536s left) kms_psr (psr2-sprite-mmap-cpu)
[485.087255] Starting subtest: psr2-sprite-mmap-cpu
[485.089585] Starting dynamic subtest: eDP-1
[486.842803] Dynamic subtest eDP-1: SUCCESS (1.755s)
[486.845255] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.757s)
[487.715904] [084/133] (533s left) kms_flip (2x-flip-vs-dpms-on-nop)
[487.797396] Starting subtest: 2x-flip-vs-dpms-on-nop
[487.809146] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[487.888880] [085/133] (533s left) dmabuf_sync_file (export-basic)
[487.928942] Starting subtest: export-basic
[487.931381] Subtest export-basic: SUCCESS (0.001s)
[487.986626] [086/133] (533s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[488.089788] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[488.178296] [087/133] (532s left) kms_getfb (getfb-handle-not-fb)
[488.283154] Starting subtest: getfb-handle-not-fb
[488.285386] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[488.386399] [088/133] (532s left) gem_userptr_blits (sync-unmap-cycles)
[488.455528] Starting subtest: sync-unmap-cycles
[493.826753] Subtest sync-unmap-cycles: SUCCESS (5.372s)
[493.961960] [089/133] (527s left) gem_softpin (overlap)
[494.023382] Starting subtest: overlap
[494.915785] Subtest overlap: SUCCESS (0.894s)
[495.028448] [090/133] (526s left) kms_dp_link_training (uhbr-mst)
[495.128019] Starting subtest: uhbr-mst
[495.136522] Subtest uhbr-mst: SKIP (0.000s)
[495.200424] [091/133] (526s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[495.325196] Starting subtest: flip-vs-cursor-crc-legacy
[496.027038] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.700s)
[496.863135] [092/133] (524s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[496.972208] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[496.974453] Starting dynamic subtest: pipe-A
[496.995745] Dynamic subtest pipe-A: SKIP (0.019s)
[497.007187] Starting dynamic subtest: pipe-B
[497.034686] Dynamic subtest pipe-B: SKIP (0.040s)
[497.047668] Starting dynamic subtest: pipe-C
[497.072988] Dynamic subtest pipe-C: SKIP (0.037s)
[497.081673] Starting dynamic subtest: pipe-D
[497.109965] Dynamic subtest pipe-D: SKIP (0.037s)
[497.113559] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.136s)
[497.214487] [093/133] (524s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[497.326718] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[504.270689] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.946s)
[504.430670] [094/133] (517s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[504.506351] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[504.610213] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.105s)
[504.689565] [095/133] (516s left) kms_cursor_crc (cursor-sliding-max-size)
[504.986407] Starting subtest: cursor-sliding-max-size
[504.992871] Subtest cursor-sliding-max-size: SKIP (0.000s)
[505.107813] [096/133] (516s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[505.219211] Starting subtest: nonblocking-crc-frame-sequence
[505.221086] Starting dynamic subtest: pipe-A-eDP-1
[505.968327] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s)
[505.980833] Starting dynamic subtest: pipe-B-eDP-1
[507.408316] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[507.420660] Starting dynamic subtest: pipe-C-eDP-1
[508.783141] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[508.792798] Starting dynamic subtest: pipe-D-eDP-1
[510.110514] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[510.112937] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.893s)
[510.912644] [097/133] (510s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[511.305938] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[512.133459] [098/133] (509s left) gem_render_copy_redux (interruptible)
[512.207466] Starting subtest: interruptible
[512.469263] Subtest interruptible: SUCCESS (0.262s)
[512.588590] [099/133] (509s left) kms_psr (pr-primary-blt)
[512.688066] Starting subtest: pr-primary-blt
[512.692226] Subtest pr-primary-blt: SKIP (0.000s)
[512.763461] [100/133] (508s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[512.880547] Starting subtest: cursor-vs-flip-legacy
[542.285159] Subtest cursor-vs-flip-legacy: SUCCESS (29.402s)
[543.077513] [101/133] (478s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[543.172521] Starting subtest: 4-tiled-16bpp-rotate-90
[543.192876] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[543.299528] [102/133] (478s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[543.401809] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[543.405685] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[543.484411] [103/133] (478s left) gem_shrink (reclaim)
[543.553070] Starting subtest: reclaim
[546.074574] Subtest reclaim: SUCCESS (2.513s)
[546.200671] [104/133] (475s left) sw_sync (alloc_fence)
[546.240400] Starting subtest: alloc_fence
[546.242734] Subtest alloc_fence: SUCCESS (0.000s)
[546.332456] [105/133] (475s left) kms_cursor_crc (cursor-onscreen-32x10)
[546.496841] Starting subtest: cursor-onscreen-32x10
[546.547552] Subtest cursor-onscreen-32x10: SKIP (0.045s)
[546.820412] [106/133] (475s left) kms_pm_rpm (universal-planes)
[549.056722] Starting subtest: universal-planes
[549.059259] Starting dynamic subtest: plane-35
[557.327117] Dynamic subtest plane-35: SUCCESS (8.273s)
[557.338487] Starting dynamic subtest: plane-65
[565.642489] Dynamic subtest plane-65: SUCCESS (8.312s)
[565.653431] Starting dynamic subtest: plane-95
[573.951796] Dynamic subtest plane-95: SUCCESS (8.305s)
[573.963952] Starting dynamic subtest: plane-125
[582.252392] Dynamic subtest plane-125: SUCCESS (8.297s)
[582.263774] Starting dynamic subtest: plane-135
[590.564242] Dynamic subtest plane-135: SUCCESS (8.309s)
[590.575857] Starting dynamic subtest: plane-145
[598.888532] Dynamic subtest plane-145: SUCCESS (8.321s)
[598.891565] Subtest universal-planes: SUCCESS (49.835s)
[599.265993] [107/133] (422s left) gem_mmap (short-mmap)
[599.316429] Subtest short-mmap: SKIP (0.000s)
[599.382023] [108/133] (422s left) gem_exec_schedule (independent)
[599.444710] Starting subtest: independent
[599.446590] Starting dynamic subtest: rcs0
[600.918985] Dynamic subtest rcs0: SUCCESS (1.481s)
[600.930716] Starting dynamic subtest: vcs0
[602.909042] Dynamic subtest vcs0: SUCCESS (1.987s)
[602.920408] Starting dynamic subtest: vcs1
[604.898460] Dynamic subtest vcs1: SUCCESS (1.987s)
[604.909220] Starting dynamic subtest: vecs0
[606.947560] Dynamic subtest vecs0: SUCCESS (2.047s)
[606.959877] Starting dynamic subtest: ccs0
[608.918490] Dynamic subtest ccs0: SUCCESS (1.968s)
[608.921325] Subtest independent: SUCCESS (9.482s)
[609.235527] [109/133] (412s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[609.347991] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[609.983139] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[610.143783] [110/133] (412s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[610.238237] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[610.242494] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[610.336736] [111/133] (411s left) gem_render_copy (y-tiled-to-vebox-linear)
[610.397240] Starting subtest: y-tiled-to-vebox-linear
[610.401686] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[610.582104] [112/133] (411s left) kms_joiner (invalid-modeset-ultra-joiner)
[610.672937] Starting subtest: invalid-modeset-ultra-joiner
[610.677308] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[610.747987] [113/133] (411s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[610.802119] Starting subtest: etime-single-wait-for-submit-submitted
[610.907092] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.104s)
[610.981818] [114/133] (411s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[611.066646] Starting subtest: psr-rgb101010-draw-mmap-cpu
[618.145240] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.080s)
[618.248610] [115/133] (404s left) gem_exec_store (basic)
[618.314128] Starting subtest: basic
[618.415344] Subtest basic: SUCCESS (0.102s)
[618.613628] [116/133] (403s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[618.702683] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[618.706780] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[618.800692] [117/133] (403s left) kms_atomic (atomic-invalid-params)
[618.902248] Starting subtest: atomic-invalid-params
[618.904575] Starting dynamic subtest: pipe-A-eDP-1
[619.296115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.393s)
[619.298437] Subtest atomic-invalid-params: SUCCESS (0.395s)
[620.117925] [118/133] (402s left) kms_color (legacy-gamma)
[620.219436] Starting subtest: legacy-gamma
[620.221369] Starting dynamic subtest: pipe-A-eDP-1
[620.934171] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[620.943376] Starting dynamic subtest: pipe-B-eDP-1
[622.314710] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s)
[622.324608] Starting dynamic subtest: pipe-C-eDP-1
[623.684619] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[623.694752] Starting dynamic subtest: pipe-D-eDP-1
[625.006625] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[625.008787] Subtest legacy-gamma: SUCCESS (4.789s)
[625.829526] [119/133] (396s left) kms_busy (extended-modeset-hang-oldfb)
[625.942177] Starting subtest: extended-modeset-hang-oldfb
[625.944847] Starting dynamic subtest: pipe-A
[638.191784] Dynamic subtest pipe-A: SUCCESS (12.248s)
[638.200997] Starting dynamic subtest: pipe-D
[650.663554] Dynamic subtest pipe-D: SUCCESS (12.468s)
[650.665847] Subtest extended-modeset-hang-oldfb: SUCCESS (24.721s)
[651.460371] [120/133] (371s left) gem_close_race (basic-threads)
[651.523591] Starting subtest: basic-threads
[652.931761] Subtest basic-threads: SUCCESS (1.408s)
[653.117706] [121/133] (369s left) kms_pm_backlight (fade)
[653.219309] Starting subtest: fade
[653.267359] Starting dynamic subtest: eDP-1
[655.750297] Dynamic subtest eDP-1: SUCCESS (2.482s)
[655.752768] Subtest fade: SUCCESS (2.533s)
[656.585509] [122/133] (366s left) kms_psr (fbc-pr-primary-mmap-gtt)
[656.684072] Starting subtest: fbc-pr-primary-mmap-gtt
[656.688282] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[656.756858] [123/133] (365s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[656.857056] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[656.861159] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[656.929141] [124/133] (365s left) kms_flip (2x-absolute-wf_vblank)
[657.029502] Starting subtest: 2x-absolute-wf_vblank
[657.040387] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[657.159554] [125/133] (365s left) gem_flink_race (flink_name)
[657.194574] Starting subtest: flink_name
[662.602048] Subtest flink_name: SUCCESS (5.389s)
[662.714434] [126/133] (360s left) kms_chamelium_color (ctm-0-25)
[662.816192] Subtest ctm-0-25: SKIP (0.000s)
[662.863370] [127/133] (360s left) kms_vblank (accuracy-idle)
[662.960402] Starting subtest: accuracy-idle
[662.962620] Starting dynamic subtest: pipe-A-eDP-1
[664.728725] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.769s)
[664.743962] Starting dynamic subtest: pipe-D-eDP-1
[667.144251] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.412s)
[667.146498] Subtest accuracy-idle: SUCCESS (4.185s)
[667.951871] [128/133] (355s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[668.056966] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[668.061107] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[668.126929] [129/133] (354s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[668.227498] Starting subtest: x-tiled-8bpp-rotate-180
[669.452594] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.226s)
[669.562815] [130/133] (353s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[669.662375] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[676.596024] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.934s)
[676.745231] [131/133] (346s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[676.841961] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[676.846258] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[676.925196] [132/133] (346s left) gem_pxp (regular-baseline-src-copy-readible)
[677.028867] Starting subtest: regular-baseline-src-copy-readible
[677.086615] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[677.217099] [133/133] (345s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[677.305569] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[677.307749] Starting dynamic subtest: pipe-A-eDP-1
[677.449765] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.137s)
[677.460681] Starting dynamic subtest: pipe-B-eDP-1
[677.480650] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[677.490176] Starting dynamic subtest: pipe-C-eDP-1
[677.511563] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[677.530112] Starting dynamic subtest: pipe-D-eDP-1
[677.550241] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[677.552214] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.146s)
[679.746829] Closing watchdogs
results: parsing output: 0/ for test: i915_drm_fdinfo
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: fbdev
results: parsing output: 5/ for test: prime_vgem
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: api_intel_bb
results: parsing output: 9/ for test: kms_rotation_crc
results: parsing output: 10/ for test: kms_plane_multiple
results: parsing output: 11/ for test: kms_content_protection
results: parsing output: 12/ for test: i915_pciid
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_ctx_isolation
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gem_mmap_wc
results: parsing output: 17/ for test: kms_invalid_mode
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: gem_spin_batch
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_chamelium_color
results: parsing output: 22/ for test: i915_pm_rpm
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: gem_mmap_offset
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: prime_self_import
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_linear_blits
results: parsing output: 32/ for test: gen7_exec_parse
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: gem_exec_fence
results: parsing output: 35/ for test: kms_vrr
results: parsing output: 36/ for test: gem_exec_params
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_lmem_swapping
results: parsing output: 39/ for test: gem_exec_balancer
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_endless
results: parsing output: 45/ for test: perf
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: api_intel_bb
results: parsing output: 48/ for test: gem_madvise
results: parsing output: 49/ for test: gem_tiled_fence_blits
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_draw_crc
results: parsing output: 52/ for test: kms_atomic_interruptible
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: i915_query
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: gem_exec_async
results: parsing output: 60/ for test: gem_tiled_pread_basic
results: parsing output: 61/ for test: kms_cursor_crc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_nop
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: gem_eio
results: parsing output: 67/ for test: sysfs_timeslice_duration
results: parsing output: 68/ for test: gem_fenced_exec_thrash
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_selftest
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_pxp
results: parsing output: 75/ for test: gem_exec_params
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_ctx_shared
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_ctx_engines
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: dmabuf_sync_file
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: kms_getfb
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: gem_softpin
results: parsing output: 89/ for test: kms_dp_link_training
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_pipe_crc_basic
results: parsing output: 96/ for test: kms_chamelium_hpd
results: parsing output: 97/ for test: gem_render_copy_redux
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_shrink
results: parsing output: 103/ for test: sw_sync
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: kms_pm_rpm
results: parsing output: 106/ for test: gem_mmap
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_joiner
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_store
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_atomic
results: parsing output: 117/ for test: kms_color
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: gem_close_race
results: parsing output: 120/ for test: kms_pm_backlight
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: gem_flink_race
results: parsing output: 125/ for test: kms_chamelium_color
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: kms_ccs
Done.