[61.694467] Initializing watchdogs
[61.694512]   /dev/watchdog0
[61.708716] [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]
[61.713072] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.715348] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.718819] [001/133] (960s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[61.850747] Starting subtest: plane-all-modeset-transition-internal-panels
[61.852631] Starting dynamic subtest: pipe-A-eDP-1
[63.159050] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.304s)
[63.440036] Starting dynamic subtest: pipe-B-eDP-1
[64.481240] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.045s)
[64.749860] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.891s)
[65.589648] [002/133] (956s left) kms_lease (lessee-list)
[65.674367] Starting subtest: lessee-list
[65.676908] Starting dynamic subtest: pipe-A-eDP-1
[65.679300] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[65.692485] Starting dynamic subtest: pipe-B-eDP-1
[65.694692] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[65.701663] Starting dynamic subtest: pipe-C-eDP-1
[65.703895] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[65.710904] Starting dynamic subtest: pipe-D-eDP-1
[65.713299] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[65.715520] Subtest lessee-list: SUCCESS (0.007s)
[65.778675] [003/133] (956s left) vgem_basic (bad-flag)
[65.850426] Starting subtest: bad-flag
[65.852283] Subtest bad-flag: SUCCESS (0.000s)
[65.900329] [FACT vgem_basic (bad-flag)] new: kernel.kmod_is_loaded.vgem: true
[65.903194] [004/133] (956s left) kms_flip (2x-flip-vs-wf_vblank)
[65.997080] Starting subtest: 2x-flip-vs-wf_vblank
[66.006709] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[66.103629] [005/133] (956s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[66.204367] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[66.206717] Starting dynamic subtest: pipe-A-eDP-1
[72.867168] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.657s)
[72.875659] Starting dynamic subtest: pipe-B-eDP-1
[79.753777] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.882s)
[79.755782] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.541s)
[80.621334] [006/133] (941s left) syncobj_timeline (transfer-timeline-point)
[80.672080] Starting subtest: transfer-timeline-point
[80.674103] Subtest transfer-timeline-point: SUCCESS (0.000s)
[80.771682] [007/133] (941s left) perf (per-context-mode-unprivileged)
[80.899739] Starting subtest: per-context-mode-unprivileged
[80.903495] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[80.945673] [008/133] (941s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[81.038184] Starting subtest: psr-1p-primscrn-cur-indfb-move
[88.264280] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.225s)
[88.384685] [009/133] (934s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[88.492791] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[88.497241] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[88.561191] [010/133] (934s left) kms_pm_backlight (fade)
[88.655926] Starting subtest: fade
[88.728728] Starting dynamic subtest: eDP-1
[91.211280] Dynamic subtest eDP-1: SUCCESS (2.480s)
[91.213527] Subtest fade: SUCCESS (2.555s)
[92.005370] [011/133] (930s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[92.096929] Starting subtest: psr-rgb565-draw-mmap-cpu
[98.778832] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.684s)
[98.878798] [012/133] (923s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[98.969832] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[98.972210] Starting dynamic subtest: pipe-A-eDP-1
[99.029381] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[99.036891] Starting dynamic subtest: pipe-B-eDP-1
[99.095267] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[99.104233] Starting dynamic subtest: pipe-C-eDP-1
[99.163048] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[99.171871] Starting dynamic subtest: pipe-D-eDP-1
[99.230072] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[99.234330] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[101.189034] [013/133] (921s left) gem_create (create-ext-placement-all)
[101.370828] Starting subtest: create-ext-placement-all
[101.373283] Subtest create-ext-placement-all: SUCCESS (0.000s)
[101.472644] [014/133] (921s left) kms_psr (fbc-psr2-suspend)
[101.560503] Starting subtest: fbc-psr2-suspend
[101.562743] Starting dynamic subtest: eDP-1
[101.566826] Dynamic subtest eDP-1: SKIP (0.000s)
[101.571023] Subtest fbc-psr2-suspend: SKIP (0.001s)
[101.629290] [015/133] (921s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[101.685799] Starting subtest: multi-wait-available-unsubmitted-signaled
[101.688165] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[101.781580] [016/133] (921s left) api_intel_bb (crc32)
[101.831190] Starting subtest: crc32
[101.833507] Starting dynamic subtest: rcs0-smem0
[102.107318] Dynamic subtest rcs0-smem0: SUCCESS (0.276s)
[102.115481] Starting dynamic subtest: bcs0-smem0
[102.440387] Dynamic subtest bcs0-smem0: SUCCESS (0.331s)
[102.451553] Starting dynamic subtest: vcs0-smem0
[102.818760] Dynamic subtest vcs0-smem0: SUCCESS (0.377s)
[102.829111] Starting dynamic subtest: vcs1-smem0
[103.220974] Dynamic subtest vcs1-smem0: SUCCESS (0.400s)
[103.232656] Starting dynamic subtest: vecs0-smem0
[103.570810] Dynamic subtest vecs0-smem0: SUCCESS (0.348s)
[103.580786] Starting dynamic subtest: ccs0-smem0
[103.906706] Dynamic subtest ccs0-smem0: SUCCESS (0.335s)
[103.909618] Subtest crc32: SUCCESS (2.077s)
[104.036880] [017/133] (918s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[104.127586] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[104.132068] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[105.228703] [018/133] (917s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[105.323074] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[105.327226] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[105.419905] [019/133] (917s left) kms_getfb (getfb2-handle-closed)
[105.509268] Starting subtest: getfb2-handle-closed
[105.511597] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[105.601395] [020/133] (917s left) gem_userptr_blits (unsync-unmap-after-close)
[105.661034] Subtest unsync-unmap-after-close: SKIP (0.000s)
[105.771889] [021/133] (917s left) gem_exec_reloc (basic-cpu-read)
[105.841687] Subtest basic-cpu-read: SKIP (0.000s)
[105.909175] [022/133] (917s left) kms_draw_crc (draw-method-mmap-wc)
[105.997592] Starting subtest: draw-method-mmap-wc
[105.999993] Starting dynamic subtest: xrgb8888-untiled
[106.207076] Dynamic subtest xrgb8888-untiled: SUCCESS (0.211s)
[106.216106] Starting dynamic subtest: rgb565-untiled
[106.395951] Dynamic subtest rgb565-untiled: SUCCESS (0.188s)
[106.405375] Starting dynamic subtest: xrgb2101010-untiled
[106.573286] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.177s)
[106.580960] Starting dynamic subtest: xbgr16161616f-untiled
[106.762440] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.188s)
[106.770029] Starting dynamic subtest: xrgb8888-xtiled
[106.895721] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[106.903710] Starting dynamic subtest: rgb565-xtiled
[107.007285] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[107.014378] Starting dynamic subtest: xrgb2101010-xtiled
[107.140716] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.131s)
[107.148365] Starting dynamic subtest: xbgr16161616f-xtiled
[107.251357] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[107.258756] Starting dynamic subtest: xrgb8888-4tiled
[107.406977] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.154s)
[107.414655] Starting dynamic subtest: rgb565-4tiled
[107.540163] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[107.547984] Starting dynamic subtest: xrgb2101010-4tiled
[107.663283] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[107.671082] Starting dynamic subtest: xbgr16161616f-4tiled
[107.818073] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.155s)
[107.820116] Subtest draw-method-mmap-wc: SUCCESS (1.823s)
[107.922336] [023/133] (915s left) perf (create-destroy-userspace-config)
[108.012619] Starting subtest: create-destroy-userspace-config
[108.034567] Subtest create-destroy-userspace-config: SUCCESS (0.020s)
[108.072525] [024/133] (915s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[108.181126] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[115.526671] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.346s)
[115.671268] [025/133] (907s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[115.769728] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[115.773744] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[115.840358] [026/133] (907s left) gem_exec_schedule (preempt-queue-contexts-chain)
[115.902535] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[116.195450] [027/133] (907s left) gem_ctx_param (root-set)
[116.251517] Starting subtest: root-set
[116.253890] Subtest root-set: SUCCESS (0.002s)
[116.353463] [028/133] (906s left) i915_drm_fdinfo (memory-info-resident)
[116.406590] Starting subtest: memory-info-resident
[116.408826] Starting dynamic subtest: smem0
[118.912743] Dynamic subtest smem0: SUCCESS (2.509s)
[118.915281] Subtest memory-info-resident: SUCCESS (2.510s)
[118.983111] [029/133] (904s left) gem_exec_fence (syncobj-timeline-signal)
[119.536627] Starting subtest: syncobj-timeline-signal
[119.549885] Subtest syncobj-timeline-signal: SUCCESS (0.015s)
[121.007942] [030/133] (902s left) prime_mmap (test_correct_cpu_write)
[121.066796] Starting subtest: test_correct_cpu_write
[121.069087] Starting dynamic subtest: test_correct_cpu_write-smem
[121.071323] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[121.073243] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[121.162527] [031/133] (902s left) kms_addfb_basic (addfb25-4-tiled)
[121.260291] Starting subtest: addfb25-4-tiled
[121.262519] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[121.365487] [032/133] (902s left) gen7_exec_parse (load-register-reg)
[121.428254] Subtest load-register-reg: SKIP (0.000s)
[121.497917] [033/133] (901s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[121.593880] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[121.598369] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[121.702519] [034/133] (901s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[121.793913] Starting subtest: yf-tiled-64bpp-rotate-270
[121.797983] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[121.889220] [035/133] (901s left) kms_psr (fbc-psr2-cursor-blt)
[121.975601] Starting subtest: fbc-psr2-cursor-blt
[121.977601] Starting dynamic subtest: eDP-1
[121.981301] Dynamic subtest eDP-1: SKIP (0.000s)
[121.984885] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[122.059880] [036/133] (901s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[122.147853] Starting subtest: x-tiled-16bpp-rotate-0
[123.505222] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.357s)
[123.616058] [037/133] (900s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[123.704701] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[123.706690] Starting dynamic subtest: pipe-A-eDP-1
[123.726053] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[123.733809] Starting dynamic subtest: pipe-B-eDP-1
[123.751756] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[123.758941] Starting dynamic subtest: pipe-C-eDP-1
[123.776840] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[123.784216] Starting dynamic subtest: pipe-D-eDP-1
[123.802154] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[123.805546] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[125.903010] [038/133] (897s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[125.973385] Starting subtest: x-tiled-to-vebox-yf-tiled
[125.978324] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[126.154994] [039/133] (897s left) gem_exec_flush (basic-wb-ro-default)
[126.217876] Starting subtest: basic-wb-ro-default
[131.670160] Subtest basic-wb-ro-default: SUCCESS (5.453s)
[131.859294] [040/133] (891s left) gem_exec_reloc (basic-cpu-gtt-active)
[131.920043] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[131.988569] [041/133] (891s left) gem_userptr_blits (map-fixed-invalidate-busy)
[132.056507] Starting subtest: map-fixed-invalidate-busy
[132.060687] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[132.192093] [042/133] (891s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[132.291528] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[139.612881] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.325s)
[139.743885] [043/133] (884s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[139.844115] Starting subtest: stress-xrgb8888-4tiled
[145.856374] Subtest stress-xrgb8888-4tiled: SUCCESS (6.012s)
[145.909227] [044/133] (878s left) kms_busy (basic)
[146.017287] Starting subtest: basic
[146.019621] Starting dynamic subtest: flip
[146.664640] Dynamic subtest flip: SUCCESS (0.646s)
[146.673283] Starting dynamic subtest: modeset
[150.060510] Dynamic subtest modeset: SUCCESS (3.395s)
[150.062876] Subtest basic: SUCCESS (4.043s)
[150.866439] [045/133] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[150.960876] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[150.965035] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[151.051976] [046/133] (872s left) kms_tiled_display (basic-test-pattern)
[151.160211] Subtest basic-test-pattern: SKIP (0.000s)
[151.206131] [047/133] (872s left) gem_ctx_persistence (legacy-engines-cleanup)
[151.270736] Starting subtest: legacy-engines-cleanup
[151.273718] Starting dynamic subtest: render
[151.323654] Dynamic subtest render: SUCCESS (0.053s)
[151.336182] Starting dynamic subtest: bsd1
[151.406936] Dynamic subtest bsd1: SUCCESS (0.079s)
[151.421433] Starting dynamic subtest: bsd2
[151.455505] Dynamic subtest bsd2: SUCCESS (0.045s)
[151.468679] Starting dynamic subtest: blt
[151.504599] Dynamic subtest blt: SUCCESS (0.046s)
[151.518634] Starting dynamic subtest: vebox
[151.569608] Dynamic subtest vebox: SUCCESS (0.062s)
[151.572062] Subtest legacy-engines-cleanup: SUCCESS (0.301s)
[151.651196] [048/133] (872s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[151.747088] Starting subtest: primary-y-tiled-reflect-x-90
[151.751074] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[151.817973] [049/133] (872s left) gem_exec_whisper (basic-contexts-forked)
[151.874028] Starting subtest: basic-contexts-forked
[175.580173] Subtest basic-contexts-forked: SUCCESS (23.700s)
[175.774134] [050/133] (848s left) kms_pm_rpm (legacy-planes-dpms)
[178.022703] Starting subtest: legacy-planes-dpms
[178.024805] Starting dynamic subtest: plane-65
[186.636389] Dynamic subtest plane-65: SUCCESS (8.616s)
[186.646058] Starting dynamic subtest: plane-95
[194.923395] Dynamic subtest plane-95: SUCCESS (8.283s)
[194.935342] Starting dynamic subtest: plane-125
[203.221249] Dynamic subtest plane-125: SUCCESS (8.295s)
[203.231909] Starting dynamic subtest: plane-135
[211.531841] Dynamic subtest plane-135: SUCCESS (8.308s)
[211.534708] Subtest legacy-planes-dpms: SUCCESS (33.512s)
[211.905870] [051/133] (812s left) gem_mmap_offset (perf)
[211.963998] Starting subtest: perf
[211.965850] Starting dynamic subtest: smem0
[212.312911] Dynamic subtest smem0: SUCCESS (0.346s)
[212.315589] Subtest perf: SUCCESS (0.347s)
[212.429611] [052/133] (811s left) syncobj_timeline (invalid-wait-illegal-handle)
[212.482478] Starting subtest: invalid-wait-illegal-handle
[212.484437] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[212.592102] [053/133] (811s left) kms_psr (fbc-psr-suspend)
[212.676665] Starting subtest: fbc-psr-suspend
[212.678803] Starting dynamic subtest: eDP-1
[212.682729] Dynamic subtest eDP-1: SKIP (0.000s)
[212.686607] Subtest fbc-psr-suspend: SKIP (0.001s)
[212.756713] [054/133] (811s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[212.867028] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[212.871501] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[212.953438] [055/133] (811s left) syncobj_eventfd (invalid-illegal-handle)
[213.014666] Starting subtest: invalid-illegal-handle
[213.016633] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[213.104600] [056/133] (811s left) gen7_exec_parse (basic-allocation)
[213.170604] Subtest basic-allocation: SKIP (0.000s)
[213.252882] [057/133] (811s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[213.349201] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[214.140966] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[214.301513] [058/133] (810s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[214.514998] Starting subtest: cursor-rapid-movement-128x128
[214.517267] Starting dynamic subtest: pipe-A-eDP-1
[215.073237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[215.102076] Starting dynamic subtest: pipe-D-eDP-1
[216.314582] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[216.317059] Subtest cursor-rapid-movement-128x128: SUCCESS (1.802s)
[217.166873] [059/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[217.261668] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[217.266069] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[217.355775] [060/133] (807s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[217.441878] Starting subtest: invalidate-primary-flip-overlay
[228.237499] Subtest invalidate-primary-flip-overlay: SUCCESS (10.797s)
[228.344790] [061/133] (796s left) kms_invalid_mode (bad-vtotal)
[228.440879] Starting subtest: bad-vtotal
[228.442892] Starting dynamic subtest: pipe-A-eDP-1
[228.720765] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[228.730897] Starting dynamic subtest: pipe-B-eDP-1
[228.733057] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[228.741789] Starting dynamic subtest: pipe-C-eDP-1
[228.744192] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[228.752655] Starting dynamic subtest: pipe-D-eDP-1
[228.755241] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[228.758021] Subtest bad-vtotal: SUCCESS (0.288s)
[229.609555] [062/133] (795s left) gem_pxp (create-regular-buffer)
[229.725083] Starting subtest: create-regular-buffer
[229.727873] Subtest create-regular-buffer: SUCCESS (0.000s)
[229.843218] [063/133] (794s left) gem_spin_batch (legacy)
[229.913993] Starting subtest: legacy
[229.916232] Starting dynamic subtest: default
[233.157021] Dynamic subtest default: SUCCESS (3.236s)
[233.168539] Starting dynamic subtest: render
[236.390677] Dynamic subtest render: SUCCESS (3.231s)
[236.402351] Starting dynamic subtest: bsd
[239.629481] Dynamic subtest bsd: SUCCESS (3.235s)
[239.641200] Starting dynamic subtest: bsd1
[242.865045] Dynamic subtest bsd1: SUCCESS (3.232s)
[242.876849] Starting dynamic subtest: bsd2
[246.105072] Dynamic subtest bsd2: SUCCESS (3.237s)
[246.116604] Starting dynamic subtest: blt
[249.346364] Dynamic subtest blt: SUCCESS (3.236s)
[249.358090] Starting dynamic subtest: vebox
[252.584134] Dynamic subtest vebox: SUCCESS (3.235s)
[252.586423] Subtest legacy: SUCCESS (22.666s)
[252.966419] [064/133] (771s left) kms_chamelium_edid (hdmi-edid-read)
[253.354668] Subtest hdmi-edid-read: SKIP (0.000s)
[254.202398] [065/133] (770s left) i915_hangman (detector)
[254.275726] Starting subtest: detector
[254.277962] Starting dynamic subtest: rcs0
[264.884573] Dynamic subtest rcs0: SUCCESS (10.605s)
[264.896844] Starting dynamic subtest: bcs0
[274.866955] Dynamic subtest bcs0: SUCCESS (9.979s)
[274.878897] Starting dynamic subtest: vcs0
[286.837983] Dynamic subtest vcs0: SUCCESS (11.968s)
[286.849229] Starting dynamic subtest: vcs1
[298.804047] Dynamic subtest vcs1: SUCCESS (11.963s)
[298.815857] Starting dynamic subtest: vecs0
[309.812536] Dynamic subtest vecs0: SUCCESS (11.005s)
[309.823968] Starting dynamic subtest: ccs0
[320.884787] Dynamic subtest ccs0: SUCCESS (11.069s)
[320.887847] Subtest detector: SUCCESS (66.607s)
[320.966344] [066/133] (703s left) gem_exec_suspend (basic)
[321.036623] Starting subtest: basic
[321.039939] Starting dynamic subtest: smem
[322.902507] Dynamic subtest smem: SUCCESS (1.864s)
[322.905569] Subtest basic: SUCCESS (1.866s)
[323.091052] [067/133] (701s left) i915_selftest (live)
[326.486826] Starting subtest: live
[326.489216] Starting dynamic subtest: sanitycheck
[330.754924] Dynamic subtest sanitycheck: SUCCESS (4.268s)
[330.764418] Starting dynamic subtest: uncore
[334.978985] Dynamic subtest uncore: SUCCESS (4.222s)
[334.993251] Starting dynamic subtest: workarounds
[352.874387] Dynamic subtest workarounds: FAIL (17.403s)
[352.881201] Starting dynamic subtest: gt_engines
[356.814960] Dynamic subtest gt_engines: SUCCESS (4.430s)
[356.822956] Starting dynamic subtest: gt_timelines
[374.541506] Dynamic subtest gt_timelines: SUCCESS (17.724s)
[374.551490] Starting dynamic subtest: gt_contexts
[378.753850] Dynamic subtest gt_contexts: SUCCESS (4.210s)
[378.765220] Starting dynamic subtest: gt_lrc
[384.713565] Dynamic subtest gt_lrc: SUCCESS (5.959s)
[384.727722] Starting dynamic subtest: gt_mocs
[388.979032] Dynamic subtest gt_mocs: SUCCESS (4.263s)
[388.988212] Starting dynamic subtest: gt_pm
[395.641834] Dynamic subtest gt_pm: SUCCESS (6.661s)
[395.651366] Starting dynamic subtest: gt_heartbeat
[399.891322] Dynamic subtest gt_heartbeat: SUCCESS (4.249s)
[399.908273] Starting dynamic subtest: gt_tlb
[409.003065] Dynamic subtest gt_tlb: SUCCESS (9.109s)
[409.012736] Starting dynamic subtest: requests
[420.527632] Dynamic subtest requests: SUCCESS (11.522s)
[420.542030] Starting dynamic subtest: migrate
[426.172231] Dynamic subtest migrate: SUCCESS (5.642s)
[426.181847] Starting dynamic subtest: active
[430.383458] Dynamic subtest active: SUCCESS (4.209s)
[430.392287] Starting dynamic subtest: objects
[435.079957] Dynamic subtest objects: SUCCESS (4.695s)
[435.089106] Starting dynamic subtest: mman
[439.777963] Dynamic subtest mman: SUCCESS (4.697s)
[439.787573] Starting dynamic subtest: dmabuf
[444.027609] Dynamic subtest dmabuf: SUCCESS (4.247s)
[444.036648] Starting dynamic subtest: vma
[446.595822] Dynamic subtest vma: SUCCESS (2.568s)
[446.605339] Starting dynamic subtest: coherency
[451.899540] Dynamic subtest coherency: SUCCESS (5.302s)
[451.907083] Starting dynamic subtest: gtt
[463.357056] Dynamic subtest gtt: SUCCESS (11.455s)
[463.366141] Starting dynamic subtest: gem
[471.523762] Dynamic subtest gem: SUCCESS (8.165s)
[471.533130] Starting dynamic subtest: evict
[476.848574] Dynamic subtest evict: SUCCESS (5.324s)
[476.859104] Starting dynamic subtest: hugepages
[487.532819] Dynamic subtest hugepages: SUCCESS (10.682s)
[487.542037] Starting dynamic subtest: gem_contexts
[514.423963] Dynamic subtest gem_contexts: SUCCESS (26.888s)
[514.433654] Starting dynamic subtest: client
[517.104310] Dynamic subtest client: SUCCESS (2.679s)
[517.111917] Starting dynamic subtest: gem_migrate
[521.351795] Dynamic subtest gem_migrate: SUCCESS (4.245s)
[521.361736] Starting dynamic subtest: reset
[525.553049] Dynamic subtest reset: SUCCESS (4.199s)
[525.562168] Starting dynamic subtest: memory_region
[529.808454] Dynamic subtest memory_region: SUCCESS (4.254s)
[529.818552] Starting dynamic subtest: hangcheck
[542.910181] Dynamic subtest hangcheck: SUCCESS (13.099s)
[542.919448] Starting dynamic subtest: execlists
[547.149025] Dynamic subtest execlists: SUCCESS (4.237s)
[547.158935] Starting dynamic subtest: ring_submission
[549.727036] Dynamic subtest ring_submission: SUCCESS (2.576s)
[549.736754] Starting dynamic subtest: perf
[554.000079] Dynamic subtest perf: SUCCESS (4.271s)
[554.009616] Starting dynamic subtest: slpc
[567.837721] Dynamic subtest slpc: SUCCESS (13.834s)
[567.846874] Starting dynamic subtest: guc
[571.597869] Dynamic subtest guc: SUCCESS (3.759s)
[571.607246] Starting dynamic subtest: guc_multi_lrc
[575.795424] Dynamic subtest guc_multi_lrc: SUCCESS (4.197s)
[575.805162] Starting dynamic subtest: guc_hang
[580.596375] Dynamic subtest guc_hang: SUCCESS (4.799s)
[580.606464] Starting dynamic subtest: late_gt_pm
[584.841957] Dynamic subtest late_gt_pm: SUCCESS (4.243s)
[584.845146] Subtest live: FAIL (258.345s)
[584.875368] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[584.876211] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[584.879552] [068/133] (440s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[586.301873] Starting subtest: etime-single-wait-for-submit-submitted
[586.408970] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[586.452525] [FACT syncobj_timeline (etime-single-wait-for-submit-submitted)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[586.453803] [FACT syncobj_timeline (etime-single-wait-for-submit-submitted)] new: kernel.kmod_is_loaded.i915: true
[586.457513] [069/133] (438s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[586.551936] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[586.554068] Starting dynamic subtest: pipe-A-eDP-1
[586.576262] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[586.586747] Starting dynamic subtest: pipe-B-eDP-1
[586.608400] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[586.616181] Starting dynamic subtest: pipe-C-eDP-1
[586.637856] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[586.645471] Starting dynamic subtest: pipe-D-eDP-1
[586.667414] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[586.671672] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[588.733178] [070/133] (436s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[588.831177] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[588.835472] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[588.928574] [071/133] (436s left) gem_exec_fence (submit)
[589.110715] Starting subtest: submit
[589.115766] Subtest submit: SKIP (0.000s)
[591.022690] [072/133] (434s left) kms_flip (2x-dpms-vs-vblank-race)
[591.121175] Starting subtest: 2x-dpms-vs-vblank-race
[591.132478] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[591.252653] [073/133] (433s left) device_reset (unbind-cold-reset-rebind)
[591.296826] Starting subtest: unbind-cold-reset-rebind
[591.301375] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[591.371920] [074/133] (433s left) kms_dp_aux_dev (basic)
[591.428834] Starting subtest: basic
[591.653471] Subtest basic: SUCCESS (0.222s)
[591.722774] [075/133] (433s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[591.814675] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[591.818792] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[591.925923] [076/133] (433s left) kms_plane_cursor (viewport)
[592.016301] Starting subtest: viewport
[592.020481] Starting dynamic subtest: pipe-A-eDP-1-size-64
[594.439231] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.424s)
[594.498515] Starting dynamic subtest: pipe-A-eDP-1-size-128
[596.884577] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.394s)
[596.944548] Starting dynamic subtest: pipe-A-eDP-1-size-256
[599.385790] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.449s)
[599.732808] Starting dynamic subtest: pipe-B-eDP-1-size-64
[602.871234] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.147s)
[602.931988] Starting dynamic subtest: pipe-B-eDP-1-size-128
[605.327651] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.405s)
[605.387509] Starting dynamic subtest: pipe-B-eDP-1-size-256
[607.807785] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.427s)
[608.155228] Starting dynamic subtest: pipe-C-eDP-1-size-64
[610.894097] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.749s)
[610.931675] Starting dynamic subtest: pipe-C-eDP-1-size-128
[612.926951] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.003s)
[612.970684] Starting dynamic subtest: pipe-C-eDP-1-size-256
[614.982505] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.024s)
[615.313944] Starting dynamic subtest: pipe-D-eDP-1-size-64
[618.027025] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.723s)
[618.064715] Starting dynamic subtest: pipe-D-eDP-1-size-128
[620.071421] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.014s)
[620.107804] Starting dynamic subtest: pipe-D-eDP-1-size-256
[622.127590] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.025s)
[622.446660] Subtest viewport: SUCCESS (30.429s)
[623.249795] [077/133] (402s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[623.307994] Starting subtest: multi-wait-for-submit-unsubmitted
[623.408967] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[623.505177] [078/133] (401s left) gem_userptr_blits (usage-restrictions)
[623.562192] Starting subtest: usage-restrictions
[623.564124] Subtest usage-restrictions: SUCCESS (0.000s)
[623.688844] [079/133] (401s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[623.745650] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[623.747925] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[623.849312] [080/133] (401s left) kms_flip (flip-vs-modeset-vs-hang)
[623.942914] Starting subtest: flip-vs-modeset-vs-hang
[623.945296] Starting dynamic subtest: A-eDP1
[675.439032] Dynamic subtest A-eDP1: SUCCESS (51.494s)
[675.449715] Starting dynamic subtest: D-eDP1
[726.380833] Dynamic subtest D-eDP1: SUCCESS (50.938s)
[726.383280] Subtest flip-vs-modeset-vs-hang: SUCCESS (102.440s)
[726.759570] [081/133] (298s left) kms_flip (flip-vs-panning-interruptible)
[726.866243] Starting subtest: flip-vs-panning-interruptible
[726.868582] Starting dynamic subtest: A-eDP1
[735.567364] Dynamic subtest A-eDP1: SUCCESS (8.700s)
[735.576445] Starting dynamic subtest: B-eDP1
[744.289651] Dynamic subtest B-eDP1: SUCCESS (8.720s)
[744.297912] Starting dynamic subtest: C-eDP1
[753.008299] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[753.016773] Starting dynamic subtest: D-eDP1
[761.638929] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[761.643545] Subtest flip-vs-panning-interruptible: SUCCESS (34.777s)
[762.809564] [082/133] (262s left) gem_ctx_isolation (clean)
[762.862512] Starting subtest: clean
[762.865063] Starting dynamic subtest: rcs0
[762.887164] Dynamic subtest rcs0: SUCCESS (0.025s)
[762.897911] Starting dynamic subtest: bcs0
[762.942096] Dynamic subtest bcs0: SUCCESS (0.054s)
[762.952410] Starting dynamic subtest: vcs0
[762.978800] Dynamic subtest vcs0: SUCCESS (0.036s)
[762.987997] Starting dynamic subtest: vcs1
[764.908504] Dynamic subtest vcs1: SUCCESS (1.928s)
[764.920043] Starting dynamic subtest: vecs0
[766.963333] Dynamic subtest vecs0: SUCCESS (2.054s)
[766.974508] Starting dynamic subtest: ccs0
[768.919438] Dynamic subtest ccs0: SUCCESS (1.955s)
[768.921933] Subtest clean: SUCCESS (6.057s)
[769.155269] [083/133] (256s left) perf_pmu (render-node-busy-idle)
[769.219854] Starting subtest: render-node-busy-idle
[769.222800] Starting dynamic subtest: rcs0
[769.909081] Dynamic subtest rcs0: SUCCESS (0.688s)
[769.920618] Starting dynamic subtest: bcs0
[770.582277] Dynamic subtest bcs0: SUCCESS (0.671s)
[770.593770] Starting dynamic subtest: vcs0
[771.928545] Dynamic subtest vcs0: SUCCESS (1.343s)
[771.938055] Starting dynamic subtest: vcs1
[773.909629] Dynamic subtest vcs1: SUCCESS (1.978s)
[773.921285] Starting dynamic subtest: vecs0
[775.894635] Dynamic subtest vecs0: SUCCESS (1.982s)
[775.906060] Starting dynamic subtest: ccs0
[776.555688] Dynamic subtest ccs0: SUCCESS (0.660s)
[776.558483] Subtest render-node-busy-idle: SUCCESS (7.336s)
[776.635532] [084/133] (248s left) kms_atomic_interruptible (universal-setplane-primary)
[776.735155] Starting subtest: universal-setplane-primary
[776.737457] Starting dynamic subtest: pipe-A-eDP-1
[784.117798] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.380s)
[784.119943] Subtest universal-setplane-primary: SUCCESS (7.381s)
[784.949276] [085/133] (240s left) kms_cursor_crc (cursor-onscreen-128x42)
[785.166888] Starting subtest: cursor-onscreen-128x42
[785.210544] Subtest cursor-onscreen-128x42: SKIP (0.039s)
[785.415564] [086/133] (240s left) gem_exec_async (forked-writes)
[785.473651] Starting subtest: forked-writes
[785.476213] Starting dynamic subtest: rcs0
[785.504336] Dynamic subtest rcs0: SUCCESS (0.030s)
[785.514505] Starting dynamic subtest: bcs0
[785.529808] Dynamic subtest bcs0: SUCCESS (0.024s)
[785.538433] Starting dynamic subtest: vcs0
[785.552226] Dynamic subtest vcs0: SUCCESS (0.022s)
[785.561705] Starting dynamic subtest: vcs1
[785.580072] Dynamic subtest vcs1: SUCCESS (0.027s)
[785.588753] Starting dynamic subtest: vecs0
[785.602884] Dynamic subtest vecs0: SUCCESS (0.022s)
[785.612345] Starting dynamic subtest: ccs0
[785.627337] Dynamic subtest ccs0: SUCCESS (0.024s)
[785.629674] Subtest forked-writes: SUCCESS (0.154s)
[785.842590] [087/133] (239s left) fbdev (unaligned-read)
[785.882224] Starting subtest: unaligned-read
[785.896125] Subtest unaligned-read: SUCCESS (0.014s)
[785.950724] [088/133] (239s left) perf (invalid-remove-userspace-config)
[786.064829] Starting subtest: invalid-remove-userspace-config
[786.076880] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[786.122381] [089/133] (239s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[786.216573] Starting subtest: blocking-absolute-wf_vblank-interruptible
[786.218855] Starting dynamic subtest: A-eDP1
[794.918219] Dynamic subtest A-eDP1: SUCCESS (8.700s)
[794.931877] Starting dynamic subtest: B-eDP1
[803.650552] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[803.663282] Starting dynamic subtest: C-eDP1
[812.379522] Dynamic subtest C-eDP1: SUCCESS (8.727s)
[812.393264] Starting dynamic subtest: D-eDP1
[821.113016] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[821.118505] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.900s)
[822.325610] [090/133] (203s left) gem_exec_balancer (full-late)
[822.383717] Starting subtest: full-late
[826.708860] Subtest full-late: SUCCESS (4.325s)
[827.035373] [091/133] (198s left) kms_cdclk (mode-transition-all-outputs)
[827.137979] Starting subtest: mode-transition-all-outputs
[827.432309] Subtest mode-transition-all-outputs: SKIP (0.294s)
[828.251611] [092/133] (197s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[828.341047] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[828.367823] Starting dynamic subtest: pipe-A-plane-0
[828.680140] Dynamic subtest pipe-A-plane-0: SUCCESS (0.311s)
[828.690028] Starting dynamic subtest: pipe-A-plane-3
[828.912346] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[828.922307] Starting dynamic subtest: pipe-A-plane-5
[828.927125] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[830.038525] Starting dynamic subtest: pipe-B-plane-0
[830.316462] Dynamic subtest pipe-B-plane-0: SUCCESS (0.288s)
[830.328329] Starting dynamic subtest: pipe-B-plane-3
[830.561553] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[830.570421] Starting dynamic subtest: pipe-B-plane-5
[830.574645] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[830.873790] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.532s)
[831.716896] [093/133] (194s left) gem_mmap_gtt (medium-copy-xy)
[831.781874] Subtest medium-copy-XY: SKIP (0.000s)
[831.837422] [094/133] (194s left) core_auth (getclient-simple)
[831.873061] Starting subtest: getclient-simple
[831.899085] Subtest getclient-simple: SUCCESS (0.025s)
[832.005191] [095/133] (194s left) kms_vblank (ts-continuation-modeset-rpm)
[832.085849] Starting subtest: ts-continuation-modeset-rpm
[832.088113] Starting dynamic subtest: pipe-A-eDP-1
[834.613680] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.526s)
[834.627921] Starting dynamic subtest: pipe-D-eDP-1
[836.847215] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.233s)
[836.849533] Subtest ts-continuation-modeset-rpm: SUCCESS (4.763s)
[837.654163] [096/133] (188s left) prime_vgem (basic-write)
[837.726321] Starting subtest: basic-write
[837.744415] Subtest basic-write: SKIP (0.016s)
[837.854778] [097/133] (188s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[837.979759] Starting subtest: cursor-vs-flip-toggle
[869.130245] Subtest cursor-vs-flip-toggle: SUCCESS (31.149s)
[869.984430] [098/133] (156s left) perf (polling-small-buf)
[870.070045] Starting subtest: polling-small-buf
[870.161330] Subtest polling-small-buf: SUCCESS (0.091s)
[870.207299] [099/133] (155s left) kms_content_protection (content-type-change)
[870.342042] Starting subtest: content-type-change
[870.346426] Subtest content-type-change: SKIP (0.000s)
[870.452638] [100/133] (155s left) gem_exec_schedule (pi-userfault)
[870.635894] Starting subtest: pi-userfault
[870.637825] Starting dynamic subtest: rcs0
[870.645517] Dynamic subtest rcs0: SUCCESS (0.011s)
[870.654732] Starting dynamic subtest: bcs0
[870.656990] Dynamic subtest bcs0: SUCCESS (0.008s)
[870.665585] Starting dynamic subtest: vcs0
[870.667875] Dynamic subtest vcs0: SUCCESS (0.009s)
[870.676454] Starting dynamic subtest: vcs1
[870.678660] Dynamic subtest vcs1: SUCCESS (0.008s)
[870.687365] Starting dynamic subtest: vecs0
[870.689204] Dynamic subtest vecs0: SUCCESS (0.008s)
[870.697692] Starting dynamic subtest: ccs0
[870.699918] Dynamic subtest ccs0: SUCCESS (0.009s)
[870.702135] Subtest pi-userfault: SUCCESS (0.059s)
[870.878385] [101/133] (155s left) gem_exec_fence (basic-wait)
[871.051326] Starting subtest: basic-wait
[871.053825] Starting dynamic subtest: rcs0
[871.130661] Dynamic subtest rcs0: SUCCESS (0.079s)
[871.141857] Starting dynamic subtest: bcs0
[871.184966] Dynamic subtest bcs0: SUCCESS (0.052s)
[871.195931] Starting dynamic subtest: vcs0
[871.237517] Dynamic subtest vcs0: SUCCESS (0.050s)
[871.247484] Starting dynamic subtest: vcs1
[871.291866] Dynamic subtest vcs1: SUCCESS (0.052s)
[871.303571] Starting dynamic subtest: vecs0
[871.348126] Dynamic subtest vecs0: SUCCESS (0.052s)
[871.358388] Starting dynamic subtest: ccs0
[871.399344] Dynamic subtest ccs0: SUCCESS (0.051s)
[871.401734] Subtest basic-wait: SUCCESS (0.350s)
[873.006277] [102/133] (153s left) gem_exec_params (dr1-dirt)
[873.056375] Starting subtest: DR1-dirt
[873.058754] Subtest DR1-dirt: SUCCESS (0.000s)
[873.154802] [103/133] (153s left) kms_flip (flip-vs-dpms-on-nop)
[873.250236] Starting subtest: flip-vs-dpms-on-nop
[873.252116] Starting dynamic subtest: A-eDP1
[875.076378] Dynamic subtest A-eDP1: SUCCESS (1.827s)
[875.087844] Starting dynamic subtest: B-eDP1
[876.906858] Dynamic subtest B-eDP1: SUCCESS (1.828s)
[876.920307] Starting dynamic subtest: C-eDP1
[878.730828] Dynamic subtest C-eDP1: SUCCESS (1.821s)
[878.743460] Starting dynamic subtest: D-eDP1
[880.558568] Dynamic subtest D-eDP1: SUCCESS (1.825s)
[880.561115] Subtest flip-vs-dpms-on-nop: SUCCESS (7.313s)
[881.750060] [104/133] (144s left) i915_query (query-topology-known-pci-ids)
[881.801240] Starting subtest: query-topology-known-pci-ids
[881.805599] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[881.943363] [105/133] (144s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[882.035896] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[882.038672] Starting dynamic subtest: pipe-A-eDP-1
[882.153024] Dynamic subtest pipe-A-eDP-1: SKIP (0.120s)
[882.164063] Starting dynamic subtest: pipe-B-eDP-1
[883.326316] Dynamic subtest pipe-B-eDP-1: SKIP (1.170s)
[883.330703] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.294s)
[884.519693] [106/133] (141s left) gem_lmem_swapping (random-engines)
[884.565120] Subtest random-engines: SKIP (0.000s)
[884.604763] [107/133] (141s left) kms_setmode (basic-clone-single-crtc)
[884.657119] Starting subtest: basic-clone-single-crtc
[884.663675] Subtest basic-clone-single-crtc: SKIP (0.000s)
[884.749176] [108/133] (141s left) kms_cursor_edge_walk (64x64-top-edge)
[884.835346] Starting subtest: 64x64-top-edge
[884.837532] Starting dynamic subtest: pipe-A-eDP-1
[888.285627] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.449s)
[888.295720] Starting dynamic subtest: pipe-D-eDP-1
[891.406325] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[891.408669] Subtest 64x64-top-edge: SUCCESS (6.573s)
[892.208611] [109/133] (134s left) kms_psr (psr-cursor-mmap-cpu)
[892.292719] Starting subtest: psr-cursor-mmap-cpu
[892.294863] Starting dynamic subtest: eDP-1
[894.013311] Dynamic subtest eDP-1: SUCCESS (1.720s)
[894.015680] Subtest psr-cursor-mmap-cpu: SUCCESS (1.721s)
[894.877826] [110/133] (131s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[894.985641] Starting subtest: short-flip-after-cursor-atomic-transitions
[895.950539] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.963s)
[896.800818] [111/133] (129s left) syncobj_wait (multi-wait-signaled)
[896.855530] Starting subtest: multi-wait-signaled
[896.857825] Subtest multi-wait-signaled: SUCCESS (0.000s)
[896.952505] [112/133] (129s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[897.056648] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[897.658399] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.603s)
[897.834739] [113/133] (128s left) kms_color (ctm-max)
[897.919286] Starting subtest: ctm-max
[897.921135] Starting dynamic subtest: pipe-A-eDP-1
[898.610084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.691s)
[898.619507] Starting dynamic subtest: pipe-B-eDP-1
[900.001089] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s)
[900.010135] Starting dynamic subtest: pipe-C-eDP-1
[901.374411] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[901.384321] Starting dynamic subtest: pipe-D-eDP-1
[902.697910] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[902.700069] Subtest ctm-max: SUCCESS (4.780s)
[903.506176] [114/133] (123s left) gem_lmem_swapping (basic)
[903.555339] Subtest basic: SKIP (0.000s)
[903.604196] [115/133] (123s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[903.712700] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[904.536280] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.825s)
[904.689377] [116/133] (122s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[904.788628] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[904.793073] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[904.888444] [117/133] (122s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[904.979580] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[904.981938] Starting dynamic subtest: pipe-A
[905.042671] Dynamic subtest pipe-A: SUCCESS (0.065s)
[905.051710] Starting dynamic subtest: pipe-B
[906.144102] Dynamic subtest pipe-B: SUCCESS (1.100s)
[906.153524] Starting dynamic subtest: pipe-C
[907.263305] Dynamic subtest pipe-C: SUCCESS (1.118s)
[907.272148] Starting dynamic subtest: pipe-D
[908.401324] Dynamic subtest pipe-D: SUCCESS (1.137s)
[908.403738] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.424s)
[909.543998] [118/133] (117s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[909.698445] Starting subtest: 2x-flip-vs-cursor-atomic
[909.702832] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[909.843928] [119/133] (117s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[909.939311] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[916.741943] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.805s)
[916.880155] [120/133] (110s left) gem_mmap_gtt (big-bo-tiledy)
[916.931807] Subtest big-bo-tiledY: SKIP (0.000s)
[917.001127] [121/133] (110s left) perf (blocking-parameterized)
[917.088729] Starting subtest: blocking-parameterized
[937.107674] Subtest blocking-parameterized: SUCCESS (20.016s)
[937.159633] [122/133] ( 90s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[937.259057] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[937.263152] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[937.362801] [123/133] ( 89s left) perf (invalid-open-flags)
[937.456518] Starting subtest: invalid-open-flags
[937.458985] Subtest invalid-open-flags: SUCCESS (0.000s)
[937.499056] [124/133] ( 89s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[937.554593] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[937.559066] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[937.750160] [125/133] ( 89s left) gem_exec_await (wide-all)
[937.944681] Starting subtest: wide-all
[961.058776] Subtest wide-all: SUCCESS (23.111s)
[961.254162] [126/133] ( 66s left) kms_plane (plane-position-hole-dpms)
[961.384978] Starting subtest: plane-position-hole-dpms
[961.887286] Starting dynamic subtest: pipe-A-plane-1
[964.206310] Dynamic subtest pipe-A-plane-1: SUCCESS (2.316s)
[964.216728] Starting dynamic subtest: pipe-A-plane-2
[966.454901] Dynamic subtest pipe-A-plane-2: SUCCESS (2.250s)
[966.464746] Starting dynamic subtest: pipe-A-plane-3
[968.810971] Dynamic subtest pipe-A-plane-3: SUCCESS (2.355s)
[968.820890] Starting dynamic subtest: pipe-A-plane-4
[971.087679] Dynamic subtest pipe-A-plane-4: SUCCESS (2.273s)
[971.097561] Starting dynamic subtest: pipe-A-plane-5
[971.111097] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[972.254315] Starting dynamic subtest: pipe-B-plane-1
[974.518898] Dynamic subtest pipe-B-plane-1: SUCCESS (2.270s)
[974.528287] Starting dynamic subtest: pipe-B-plane-2
[976.790474] Dynamic subtest pipe-B-plane-2: SUCCESS (2.273s)
[976.801849] Starting dynamic subtest: pipe-B-plane-3
[979.153125] Dynamic subtest pipe-B-plane-3: SUCCESS (2.360s)
[979.162724] Starting dynamic subtest: pipe-B-plane-4
[981.516222] Dynamic subtest pipe-B-plane-4: SUCCESS (2.362s)
[981.526652] Starting dynamic subtest: pipe-B-plane-5
[981.539653] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[981.541887] Subtest plane-position-hole-dpms: SUCCESS (20.154s)
[982.331960] [127/133] ( 45s left) gem_exec_reloc (basic-wc-noreloc)
[982.399662] Subtest basic-wc-noreloc: SKIP (0.000s)
[982.474546] [128/133] ( 44s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[982.578297] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[982.580609] Starting dynamic subtest: pipe-A-default-mode
[985.284603] Dynamic subtest pipe-A-default-mode: SUCCESS (2.705s)
[985.286482] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.706s)
[986.131686] [129/133] ( 41s left) kms_flip (bo-too-big)
[986.222347] Starting subtest: bo-too-big
[986.224745] Starting dynamic subtest: A-eDP1
[987.582478] Dynamic subtest A-eDP1: SUCCESS (1.359s)
[987.591809] Starting dynamic subtest: B-eDP1
[988.912472] Dynamic subtest B-eDP1: SUCCESS (1.329s)
[988.927485] Starting dynamic subtest: C-eDP1
[990.250828] Dynamic subtest C-eDP1: SUCCESS (1.336s)
[990.262320] Starting dynamic subtest: D-eDP1
[991.584480] Dynamic subtest D-eDP1: SUCCESS (1.333s)
[991.589391] Subtest bo-too-big: SUCCESS (5.368s)
[992.793814] [130/133] ( 34s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[993.176745] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[994.000590] [131/133] ( 33s left) kms_frontbuffer_tracking (fbc-2p-rte)
[994.102469] Starting subtest: fbc-2p-rte
[994.106751] Subtest fbc-2p-rte: SKIP (0.000s)
[994.211848] [132/133] ( 33s left) i915_pm_rpm (gem-idle)
[996.036636] Starting subtest: gem-idle
[1002.228940] Subtest gem-idle: SUCCESS (6.192s)
[1002.572931] [133/133] ( 25s left) kms_atomic (plane-primary-legacy)
[1003.870077] Starting subtest: plane-primary-legacy
[1003.872375] Starting dynamic subtest: pipe-A-eDP-1
[1004.309816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[1004.312294] Subtest plane-primary-legacy: SUCCESS (0.442s)
[1005.185185] Closing watchdogs
results: parsing output: 0/ for test: kms_atomic_transition
results: parsing output: 1/ for test: kms_lease
results: parsing output: 2/ for test: vgem_basic
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_pm_backlight
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: gem_create
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: api_intel_bb
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_getfb
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: kms_draw_crc
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: prime_mmap
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: gen7_exec_parse
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: gem_exec_flush
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_pipe_stress
results: parsing output: 43/ for test: kms_busy
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_tiled_display
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: kms_rotation_crc
results: parsing output: 48/ for test: gem_exec_whisper
results: parsing output: 49/ for test: kms_pm_rpm
results: parsing output: 50/ for test: gem_mmap_offset
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: syncobj_eventfd
results: parsing output: 55/ for test: gen7_exec_parse
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_psr_stress_test
results: parsing output: 60/ for test: kms_invalid_mode
results: parsing output: 61/ for test: gem_pxp
results: parsing output: 62/ for test: gem_spin_batch
results: parsing output: 63/ for test: kms_chamelium_edid
results: parsing output: 64/ for test: i915_hangman
results: parsing output: 65/ for test: gem_exec_suspend
results: parsing output: 66/ for test: i915_selftest
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: device_reset
results: parsing output: 73/ for test: kms_dp_aux_dev
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_plane_cursor
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: gem_userptr_blits
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: gem_ctx_isolation
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: kms_atomic_interruptible
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: gem_exec_async
results: parsing output: 86/ for test: fbdev
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_cdclk
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: core_auth
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: prime_vgem
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: kms_content_protection
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: i915_query
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: gem_lmem_swapping
results: parsing output: 106/ for test: kms_setmode
results: parsing output: 107/ for test: kms_cursor_edge_walk
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_color
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: gem_exec_await
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_chamelium_hpd
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: i915_pm_rpm
results: parsing output: 132/ for test: kms_atomic
Done.