[64.198472] Initializing watchdogs
[64.198516]   /dev/watchdog0
[64.211987] [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]
[64.216339] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.218456] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.221908] [001/134] (960s left) kms_cursor_crc (cursor-onscreen-256x256)
[64.484097] Starting subtest: cursor-onscreen-256x256
[64.494831] Starting dynamic subtest: pipe-A-eDP-1
[66.673857] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.175s)
[66.703797] Starting dynamic subtest: pipe-D-eDP-1
[69.491079] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.788s)
[69.493929] Subtest cursor-onscreen-256x256: SUCCESS (5.003s)
[70.360182] [002/134] (954s left) kms_vblank (query-forked-hang)
[70.453371] Starting subtest: query-forked-hang
[70.455728] Starting dynamic subtest: pipe-A-eDP-1
[96.670614] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.206s)
[96.683673] Starting dynamic subtest: pipe-D-eDP-1
[111.698077] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.022s)
[111.700295] Subtest query-forked-hang: SUCCESS (41.232s)
[112.532684] [003/134] (912s left) perf (per-context-mode-unprivileged)
[112.670334] Starting subtest: per-context-mode-unprivileged
[112.674588] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[112.708040] [004/134] (912s left) kms_lease (atomic-implicit-crtc)
[112.800686] Starting subtest: atomic-implicit-crtc
[112.803296] Starting dynamic subtest: pipe-A-eDP-1
[112.814990] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[112.825055] Starting dynamic subtest: pipe-B-eDP-1
[112.836830] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[112.843854] Starting dynamic subtest: pipe-C-eDP-1
[112.854629] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[112.861326] Starting dynamic subtest: pipe-D-eDP-1
[112.872119] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[112.874219] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[112.952205] [005/134] (911s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[113.060891] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[113.863269] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.804s)
[114.095413] [006/134] (910s left) kms_vrr (seamless-rr-switch-vrr)
[114.200316] Starting subtest: seamless-rr-switch-vrr
[114.208058] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[114.278518] [007/134] (910s left) syncobj_wait (single-wait-all-signaled)
[114.345983] Starting subtest: single-wait-all-signaled
[114.348260] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[114.470294] [008/134] (910s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[114.565072] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[114.567563] Starting dynamic subtest: pipe-A-eDP-1
[114.626232] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[114.635130] Starting dynamic subtest: pipe-B-eDP-1
[114.692562] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[114.700529] Starting dynamic subtest: pipe-C-eDP-1
[114.756084] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[114.764621] Starting dynamic subtest: pipe-D-eDP-1
[114.812462] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[114.816255] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.007s)
[116.894464] [009/134] (908s left) perf (polling-small-buf)
[116.988511] Starting subtest: polling-small-buf
[117.081097] Subtest polling-small-buf: SUCCESS (0.089s)
[117.123045] [010/134] (907s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[117.182378] Starting subtest: invalid-multi-wait-all-unsubmitted
[117.184767] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[117.293263] [011/134] (907s left) syncobj_timeline (single-wait-all-available-submitted)
[117.358039] Starting subtest: single-wait-all-available-submitted
[117.360327] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[117.481182] [012/134] (907s left) gem_ctx_create (basic-files)
[117.544659] Starting subtest: basic-files
[119.552301] Subtest basic-files: SUCCESS (2.008s)
[120.973480] [013/134] (904s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[121.080054] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[121.084292] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[121.194678] [014/134] (904s left) gem_exec_suspend (basic-s3)
[121.258954] Starting subtest: basic-S3
[121.261402] Starting dynamic subtest: smem
[141.675219] Dynamic subtest smem: SUCCESS (6.607s)
[141.677831] Subtest basic-S3: SUCCESS (6.609s)
[141.872477] [015/134] (883s left) gem_exec_params (invalid-ring)
[141.949337] Starting subtest: invalid-ring
[141.951804] Subtest invalid-ring: SUCCESS (0.000s)
[142.083921] [016/134] (883s left) gem_caching (reads)
[142.147575] Subtest reads: SKIP (0.000s)
[142.234736] [017/134] (883s left) kms_psr (psr-sprite-mmap-cpu)
[142.340102] Starting subtest: psr-sprite-mmap-cpu
[142.342512] Starting dynamic subtest: eDP-1
[144.107449] Dynamic subtest eDP-1: SUCCESS (1.746s)
[144.109755] Subtest psr-sprite-mmap-cpu: SUCCESS (1.746s)
[144.972255] [018/134] (880s left) gem_exec_reloc (basic-gtt-read-noreloc)
[145.029657] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[145.094526] [019/134] (880s left) gem_mmap_gtt (basic-small-copy)
[145.156208] Subtest basic-small-copy: SKIP (0.000s)
[145.227076] [020/134] (880s left) kms_pm_backlight (fade-with-dpms)
[145.326229] Starting subtest: fade-with-dpms
[147.458830] Starting dynamic subtest: eDP-1
[150.153087] Dynamic subtest eDP-1: SUCCESS (2.675s)
[150.156068] Subtest fade-with-dpms: SUCCESS (4.792s)
[150.974368] [021/134] (874s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[151.075708] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[151.079922] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[151.198826] [022/134] (874s left) kms_async_flips (async-flip-hang)
[151.299479] Starting subtest: async-flip-hang
[151.675112] Starting dynamic subtest: pipe-A-eDP-1
[178.176761] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.464s)
[178.560772] Starting dynamic subtest: pipe-B-eDP-1
[194.183638] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.624s)
[194.569814] Starting dynamic subtest: pipe-C-eDP-1
[210.179411] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.609s)
[210.567015] Starting dynamic subtest: pipe-D-eDP-1
[226.183239] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.618s)
[226.185633] Subtest async-flip-hang: SUCCESS (74.829s)
[227.374422] [023/134] (798s left) kms_vblank (wait-busy)
[227.470540] Starting subtest: wait-busy
[227.472779] Starting dynamic subtest: pipe-A-eDP-1
[229.375617] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.906s)
[229.390034] Starting dynamic subtest: pipe-D-eDP-1
[231.933260] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.554s)
[231.935624] Subtest wait-busy: SUCCESS (4.463s)
[232.757001] [024/134] (792s left) gem_exec_params (invalid-fence-in)
[232.821252] Starting subtest: invalid-fence-in
[232.823511] Subtest invalid-fence-in: SUCCESS (0.000s)
[232.945068] [025/134] (792s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[233.038134] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[233.040444] Starting dynamic subtest: pipe-A-default-mode
[234.204624] Dynamic subtest pipe-A-default-mode: SKIP (1.163s)
[234.208820] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.165s)
[234.412462] [026/134] (791s left) dmabuf_sync_file (export-basic)
[234.524898] Starting subtest: export-basic
[234.527217] Subtest export-basic: SUCCESS (0.002s)
[234.598889] [FACT dmabuf_sync_file (export-basic)] new: kernel.kmod_is_loaded.vgem: true
[234.602143] [027/134] (791s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[234.673474] Starting subtest: map-fixed-invalidate-overlap-busy
[234.677903] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[234.805233] [028/134] (790s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[234.896347] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[234.921789] Starting dynamic subtest: pipe-A-plane-0
[234.926291] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[234.934811] Starting dynamic subtest: pipe-A-plane-3
[234.939401] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[234.947582] Starting dynamic subtest: pipe-A-plane-5
[234.952287] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[236.053600] Starting dynamic subtest: pipe-B-plane-0
[236.057904] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[236.067417] Starting dynamic subtest: pipe-B-plane-3
[236.070999] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[236.078182] Starting dynamic subtest: pipe-B-plane-5
[236.081767] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[236.361698] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (1.463s)
[237.237076] [029/134] (788s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[237.336327] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[237.340328] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[237.463715] [030/134] (788s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[237.542462] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[237.547125] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[238.674800] [031/134] (787s left) gem_mmap_gtt (zero-extend)
[238.732421] Subtest zero-extend: SKIP (0.000s)
[238.797925] [032/134] (787s left) kms_content_protection (legacy)
[238.936945] Starting subtest: legacy
[238.941617] Subtest legacy: SKIP (0.000s)
[239.080630] [033/134] (786s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[239.167243] Starting subtest: plane-all-modeset-transition-internal-panels
[239.169194] Starting dynamic subtest: pipe-A-eDP-1
[240.505988] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.338s)
[240.786027] Starting dynamic subtest: pipe-B-eDP-1
[241.835381] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.060s)
[242.118346] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.953s)
[242.963666] [034/134] (783s left) kms_flip (2x-busy-flip)
[243.064522] Starting subtest: 2x-busy-flip
[243.076241] Subtest 2x-busy-flip: SKIP (0.011s)
[243.178606] [035/134] (782s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[243.281933] Starting subtest: psr-rgb565-draw-mmap-cpu
[250.058469] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.780s)
[250.192911] [036/134] (775s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[250.288355] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[250.313812] Starting dynamic subtest: pipe-A-plane-0
[250.318521] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[250.328860] Starting dynamic subtest: pipe-A-plane-3
[250.333504] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[250.341869] Starting dynamic subtest: pipe-A-plane-5
[250.346562] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[251.373558] Starting dynamic subtest: pipe-B-plane-0
[251.378430] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[251.390768] Starting dynamic subtest: pipe-B-plane-3
[251.395521] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[251.407991] Starting dynamic subtest: pipe-B-plane-5
[251.412858] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[251.688273] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (1.398s)
[252.556086] [037/134] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[252.645260] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[252.649216] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[252.745817] [038/134] (773s left) kms_draw_crc (draw-method-blt)
[252.851358] Starting subtest: draw-method-blt
[252.853595] Starting dynamic subtest: xrgb8888-untiled
[253.082423] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[253.091066] Starting dynamic subtest: rgb565-untiled
[253.304206] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[253.312224] Starting dynamic subtest: xrgb2101010-untiled
[253.515287] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[253.523358] Starting dynamic subtest: xbgr16161616f-untiled
[253.715317] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[253.724456] Starting dynamic subtest: xrgb8888-xtiled
[253.826220] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[253.834191] Starting dynamic subtest: rgb565-xtiled
[253.937200] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[253.945240] Starting dynamic subtest: xrgb2101010-xtiled
[254.037506] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.100s)
[254.045490] Starting dynamic subtest: xbgr16161616f-xtiled
[254.137643] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.099s)
[254.145606] Starting dynamic subtest: xrgb8888-4tiled
[254.270615] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[254.279602] Starting dynamic subtest: rgb565-4tiled
[254.437528] Dynamic subtest rgb565-4tiled: SUCCESS (0.165s)
[254.445189] Starting dynamic subtest: xrgb2101010-4tiled
[254.548661] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[254.556577] Starting dynamic subtest: xbgr16161616f-4tiled
[254.670725] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.120s)
[254.672499] Subtest draw-method-blt: SUCCESS (1.822s)
[254.821623] [039/134] (771s left) kms_hdr (static-toggle-dpms)
[254.924659] Starting subtest: static-toggle-dpms
[254.929791] Subtest static-toggle-dpms: SKIP (0.000s)
[254.993877] [040/134] (771s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[255.107557] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[260.355626] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.250s)
[261.547244] [041/134] (764s left) sw_sync (alloc_fence_invalid_timeline)
[261.588464] Starting subtest: alloc_fence_invalid_timeline
[261.590808] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[261.657553] [042/134] (764s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[261.755856] Starting subtest: bad-rotation-90-y-tiled-ccs
[261.758099] Starting dynamic subtest: pipe-A-eDP-1
[261.780018] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[261.791210] Starting dynamic subtest: pipe-B-eDP-1
[261.811381] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[261.819478] Starting dynamic subtest: pipe-C-eDP-1
[261.840531] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[261.849419] Starting dynamic subtest: pipe-D-eDP-1
[261.871234] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[261.875533] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[264.010673] [043/134] (762s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[264.113687] Starting subtest: fbcpsr-rgb101010-draw-render
[270.874422] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.763s)
[271.021428] [044/134] (755s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[271.129229] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[271.131540] Starting dynamic subtest: pipe-A-eDP-1
[271.156950] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[271.167376] Starting dynamic subtest: pipe-B-eDP-1
[271.191238] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[271.199375] Starting dynamic subtest: pipe-C-eDP-1
[271.224297] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[271.232281] Starting dynamic subtest: pipe-D-eDP-1
[271.256541] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[271.260667] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[273.390852] [045/134] (753s left) gem_exec_fence (long-history)
[273.806139] Starting subtest: long-history
[281.444220] Subtest long-history: SUCCESS (7.637s)
[281.898505] [046/134] (744s left) gem_ctx_persistence (legacy-engines-hang)
[281.959120] Starting subtest: legacy-engines-hang
[281.961434] Starting dynamic subtest: render
[282.065477] Dynamic subtest render: SUCCESS (0.105s)
[282.079910] Starting dynamic subtest: bsd1
[282.169957] Dynamic subtest bsd1: SUCCESS (0.101s)
[282.181390] Starting dynamic subtest: bsd2
[282.282977] Dynamic subtest bsd2: SUCCESS (0.111s)
[282.294140] Starting dynamic subtest: blt
[282.384141] Dynamic subtest blt: SUCCESS (0.099s)
[282.395451] Starting dynamic subtest: vebox
[282.492964] Dynamic subtest vebox: SUCCESS (0.107s)
[282.495711] Subtest legacy-engines-hang: SUCCESS (0.535s)
[282.584463] [047/134] (743s left) kms_plane_alpha_blend (constant-alpha-mid)
[282.691056] Starting subtest: constant-alpha-mid
[282.979195] Starting dynamic subtest: pipe-A-eDP-1
[283.858542] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.878s)
[283.868750] Starting dynamic subtest: pipe-D-eDP-1
[285.372564] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.511s)
[285.374902] Subtest constant-alpha-mid: SUCCESS (2.681s)
[286.186232] [048/134] (740s left) gem_pxp (fail-invalid-protected-context)
[286.326061] Starting subtest: fail-invalid-protected-context
[286.328824] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[286.451452] [049/134] (740s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[286.560045] Starting subtest: 4-tiled-8bpp-rotate-180
[287.773346] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.214s)
[287.933405] [050/134] (738s left) kms_atomic_transition (modeset-transition-fencing)
[288.036521] Starting subtest: modeset-transition-fencing
[288.038207] Starting dynamic subtest: 1x-outputs
[298.828960] Dynamic subtest 1x-outputs: SUCCESS (10.791s)
[298.831595] Subtest modeset-transition-fencing: SUCCESS (10.792s)
[299.701455] [051/134] (726s left) kms_psr (psr2-sprite-mmap-cpu)
[299.806086] Starting subtest: psr2-sprite-mmap-cpu
[299.808342] Starting dynamic subtest: eDP-1
[301.481562] Dynamic subtest eDP-1: SUCCESS (1.674s)
[301.483786] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.675s)
[302.388092] [052/134] (724s left) gem_partial_pwrite_pread (write-uncached)
[302.459744] Subtest write-uncached: SKIP (0.000s)
[302.542873] [053/134] (724s left) gem_exec_schedule (wide)
[302.727123] Starting subtest: wide
[302.729636] Starting dynamic subtest: rcs0
[312.209379] Dynamic subtest rcs0: SUCCESS (9.478s)
[312.220599] Starting dynamic subtest: vcs0
[324.361192] Dynamic subtest vcs0: SUCCESS (12.147s)
[324.372571] Starting dynamic subtest: vcs1
[334.356124] Dynamic subtest vcs1: SUCCESS (9.992s)
[334.367177] Starting dynamic subtest: vecs0
[344.984706] Dynamic subtest vecs0: SUCCESS (10.624s)
[344.997758] Starting dynamic subtest: ccs0
[359.900849] Dynamic subtest ccs0: SUCCESS (14.910s)
[359.903734] Subtest wide: SUCCESS (57.157s)
[362.749745] [054/134] (664s left) kms_plane (plane-position-hole)
[362.849224] Starting subtest: plane-position-hole
[363.350931] Starting dynamic subtest: pipe-A-plane-1
[364.663309] Dynamic subtest pipe-A-plane-1: SUCCESS (1.313s)
[364.676326] Starting dynamic subtest: pipe-A-plane-2
[365.941115] Dynamic subtest pipe-A-plane-2: SUCCESS (1.276s)
[365.950663] Starting dynamic subtest: pipe-A-plane-3
[367.194990] Dynamic subtest pipe-A-plane-3: SUCCESS (1.253s)
[367.204016] Starting dynamic subtest: pipe-A-plane-4
[368.434422] Dynamic subtest pipe-A-plane-4: SUCCESS (1.241s)
[368.443894] Starting dynamic subtest: pipe-A-plane-5
[368.463292] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[369.581071] Starting dynamic subtest: pipe-B-plane-1
[370.794719] Dynamic subtest pipe-B-plane-1: SUCCESS (1.226s)
[370.806876] Starting dynamic subtest: pipe-B-plane-2
[372.046884] Dynamic subtest pipe-B-plane-2: SUCCESS (1.252s)
[372.056258] Starting dynamic subtest: pipe-B-plane-3
[373.346814] Dynamic subtest pipe-B-plane-3: SUCCESS (1.300s)
[373.356264] Starting dynamic subtest: pipe-B-plane-4
[374.582032] Dynamic subtest pipe-B-plane-4: SUCCESS (1.237s)
[374.592069] Starting dynamic subtest: pipe-B-plane-5
[374.607838] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[374.610138] Subtest plane-position-hole: SUCCESS (11.763s)
[375.388183] [055/134] (651s left) kms_flip (2x-plain-flip-interruptible)
[375.489281] Starting subtest: 2x-plain-flip-interruptible
[375.500686] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[375.648842] [056/134] (651s left) gem_exec_async (concurrent-writes)
[375.709723] Starting subtest: concurrent-writes
[375.712006] Starting dynamic subtest: rcs0
[375.724238] Dynamic subtest rcs0: SUCCESS (0.015s)
[375.734029] Starting dynamic subtest: bcs0
[375.736311] Dynamic subtest bcs0: SUCCESS (0.005s)
[375.744460] Starting dynamic subtest: vcs0
[375.746543] Dynamic subtest vcs0: SUCCESS (0.004s)
[375.754429] Starting dynamic subtest: vcs1
[375.756258] Dynamic subtest vcs1: SUCCESS (0.005s)
[375.763981] Starting dynamic subtest: vecs0
[375.765784] Dynamic subtest vecs0: SUCCESS (0.005s)
[375.773266] Starting dynamic subtest: ccs0
[375.775123] Dynamic subtest ccs0: SUCCESS (0.006s)
[375.776963] Subtest concurrent-writes: SUCCESS (0.045s)
[376.022513] [057/134] (650s left) kms_prop_blob (invalid-set-prop-any)
[376.083745] Starting subtest: invalid-set-prop-any
[376.085611] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[376.203672] [058/134] (650s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[376.302867] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[376.307198] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[376.402323] [059/134] (650s left) gem_exec_create (madvise)
[376.470374] Starting subtest: madvise
[376.472467] Starting dynamic subtest: smem
[396.635234] Dynamic subtest smem: SUCCESS (20.162s)
[396.637668] Subtest madvise: SUCCESS (20.163s)
[397.591142] [060/134] (629s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[397.701202] Starting subtest: compare-crc-sanitycheck-nv12
[397.703179] Starting dynamic subtest: pipe-A-eDP-1
[398.409012] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.706s)
[398.418068] Starting dynamic subtest: pipe-B-eDP-1
[399.636337] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.228s)
[399.644817] Starting dynamic subtest: pipe-C-eDP-1
[400.837412] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.196s)
[400.854556] Starting dynamic subtest: pipe-D-eDP-1
[402.055748] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[402.058111] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.357s)
[402.904507] [061/134] (624s left) kms_rmfb (rmfb-ioctl)
[403.005562] Starting subtest: rmfb-ioctl
[403.007847] Starting dynamic subtest: pipe-A-eDP-1
[403.112736] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s)
[403.123455] Starting dynamic subtest: pipe-B-eDP-1
[404.262923] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.149s)
[404.272912] Starting dynamic subtest: pipe-C-eDP-1
[405.393384] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.129s)
[405.401806] Starting dynamic subtest: pipe-D-eDP-1
[406.523948] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[406.526360] Subtest rmfb-ioctl: SUCCESS (3.522s)
[407.734157] [062/134] (619s left) gen9_exec_parse (bb-start-far)
[407.800353] Subtest bb-start-far: SKIP (0.000s)
[407.880823] [063/134] (619s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[407.983250] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[415.217272] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.237s)
[415.377180] [064/134] (611s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[415.768231] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[416.578630] [065/134] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[416.689308] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[423.476866] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.789s)
[423.673196] [066/134] (603s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[423.781947] Starting subtest: fbcpsr-suspend
[464.480749] Subtest fbcpsr-suspend: SUCCESS (10.142s)
[464.595741] [067/134] (562s left) i915_module_load (resize-bar)
[464.640147] Starting subtest: resize-bar
[464.648945] Subtest resize-bar: SKIP (0.005s)
[464.693528] [068/134] (562s left) gem_exec_schedule (thriceslice)
[464.762153] Starting subtest: thriceslice
[464.764956] Starting dynamic subtest: rcs0
[464.781062] Dynamic subtest rcs0: SUCCESS (0.031s)
[464.790491] Starting dynamic subtest: bcs0
[464.836310] Dynamic subtest bcs0: SUCCESS (0.052s)
[464.847025] Starting dynamic subtest: vcs0
[464.887821] Dynamic subtest vcs0: SUCCESS (0.050s)
[464.899969] Starting dynamic subtest: vcs1
[464.943151] Dynamic subtest vcs1: SUCCESS (0.052s)
[464.952294] Starting dynamic subtest: vecs0
[464.975096] Dynamic subtest vecs0: SUCCESS (0.030s)
[464.984450] Starting dynamic subtest: ccs0
[465.028649] Dynamic subtest ccs0: SUCCESS (0.051s)
[465.031298] Subtest thriceslice: SUCCESS (0.276s)
[466.243512] [069/134] (561s left) gem_pxp (create-valid-protected-context)
[466.348879] Starting subtest: create-valid-protected-context
[466.351732] Subtest create-valid-protected-context: SUCCESS (0.001s)
[466.476971] [070/134] (560s left) perf_pmu (pmu-read)
[466.521622] Starting subtest: pmu-read
[466.523818] Subtest pmu-read: SUCCESS (0.002s)
[466.653084] [071/134] (560s left) gem_eio (wait-immediate)
[466.881142] Starting subtest: wait-immediate
[467.265576] Subtest wait-immediate: SUCCESS (0.383s)
[467.427096] [072/134] (560s left) gem_ctx_persistence (engines-hang)
[467.481263] Starting subtest: engines-hang
[467.483741] Starting dynamic subtest: rcs0
[467.624968] Dynamic subtest rcs0: SUCCESS (0.142s)
[467.637524] Starting dynamic subtest: bcs0
[467.708325] Dynamic subtest bcs0: SUCCESS (0.081s)
[467.719440] Starting dynamic subtest: vcs0
[467.852909] Dynamic subtest vcs0: SUCCESS (0.141s)
[467.863050] Starting dynamic subtest: vcs1
[467.974169] Dynamic subtest vcs1: SUCCESS (0.119s)
[467.986071] Starting dynamic subtest: vecs0
[468.095619] Dynamic subtest vecs0: SUCCESS (0.118s)
[468.108191] Starting dynamic subtest: ccs0
[468.172066] Dynamic subtest ccs0: SUCCESS (0.074s)
[468.174757] Subtest engines-hang: SUCCESS (0.686s)
[468.263176] [073/134] (559s left) gem_softpin (allocator-nopin-reserve)
[468.330176] Starting subtest: allocator-nopin-reserve
[468.442520] Subtest allocator-nopin-reserve: SUCCESS (0.113s)
[468.588648] [074/134] (559s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[468.695269] Starting subtest: y-tiled-16bpp-rotate-0
[468.700556] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[468.804635] [075/134] (558s left) syncobj_wait (wait-delayed-signal)
[468.869172] Starting subtest: wait-delayed-signal
[468.969212] Subtest wait-delayed-signal: SUCCESS (0.102s)
[469.058826] [076/134] (558s left) gem_exec_balancer (nop)
[469.119585] Starting subtest: nop
[515.911333] Subtest nop: SUCCESS (46.732s)
[516.244460] [077/134] (511s left) i915_drm_fdinfo (memory-info-purgeable)
[516.289697] Starting subtest: memory-info-purgeable
[516.292214] Starting dynamic subtest: smem0
[519.113037] Dynamic subtest smem0: SUCCESS (2.826s)
[519.115455] Subtest memory-info-purgeable: SUCCESS (2.827s)
[519.199702] [078/134] (508s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[519.305495] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[523.407628] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.105s)
[524.584599] [079/134] (503s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[524.692216] Starting subtest: fbc-pr-sprite-mmap-cpu
[524.697534] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[524.791315] [080/134] (503s left) syncobj_timeline (multi-wait-available-submitted)
[524.853150] Starting subtest: multi-wait-available-submitted
[524.856062] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[524.966148] [081/134] (502s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[525.073126] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[525.079037] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[526.212536] [082/134] (501s left) fbdev (info)
[526.249016] Starting subtest: info
[526.251934] Subtest info: SUCCESS (0.000s)
[526.321548] [083/134] (501s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[526.421287] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[526.423898] Starting dynamic subtest: pipe-A-default-mode
[526.713980] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[526.720006] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.288s)
[527.548238] [084/134] (500s left) gem_create (create-ext-placement-all)
[527.725038] Starting subtest: create-ext-placement-all
[527.728167] Subtest create-ext-placement-all: SUCCESS (0.000s)
[527.847921] [085/134] (500s left) sysfs_timeslice_duration (timeout)
[527.915406] Starting subtest: timeout
[527.918169] Starting dynamic subtest: vecs0
[537.180340] Dynamic subtest vecs0: SUCCESS (9.259s)
[537.194991] Starting dynamic subtest: ccs0
[538.526989] Dynamic subtest ccs0: SUCCESS (1.345s)
[538.537067] Starting dynamic subtest: vcs0
[548.179953] Dynamic subtest vcs0: SUCCESS (9.645s)
[548.191153] Starting dynamic subtest: bcs0
[548.821244] Dynamic subtest bcs0: SUCCESS (0.640s)
[548.832669] Starting dynamic subtest: rcs0
[550.143556] Dynamic subtest rcs0: SUCCESS (1.322s)
[550.154367] Starting dynamic subtest: vcs1
[560.203741] Dynamic subtest vcs1: SUCCESS (10.052s)
[560.206693] Subtest timeout: SUCCESS (32.277s)
[560.291626] [086/134] (467s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[560.349139] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[560.411415] [087/134] (467s left) gem_mmap_gtt (cpuset-big-copy-xy)
[560.478884] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[560.552420] [088/134] (467s left) syncobj_wait (invalid-signal-bad-pad)
[560.605666] Starting subtest: invalid-signal-bad-pad
[560.607987] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[560.728575] [089/134] (467s left) gem_vm_create (execbuf)
[560.792571] Starting subtest: execbuf
[560.801948] Subtest execbuf: SUCCESS (0.013s)
[560.971358] [090/134] (467s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[561.027912] Starting subtest: multi-wait-all-for-submit-unsubmitted
[561.135153] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[561.231947] [091/134] (467s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[561.351975] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[561.357146] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[561.451448] [092/134] (466s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[563.292581] Starting subtest: modeset-non-lpsp-stress-no-wait
[563.323167] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.032s)
[563.700626] [093/134] (464s left) kms_color (legacy-gamma-reset)
[563.796610] Starting subtest: legacy-gamma-reset
[563.798734] Starting dynamic subtest: pipe-A-eDP-1
[564.169677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.375s)
[564.178846] Starting dynamic subtest: pipe-B-eDP-1
[564.181058] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[564.189972] Starting dynamic subtest: pipe-C-eDP-1
[564.194784] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[564.203684] Starting dynamic subtest: pipe-D-eDP-1
[564.206072] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[564.208563] Subtest legacy-gamma-reset: SUCCESS (0.411s)
[565.019933] [094/134] (463s left) kms_cursor_crc (cursor-random-128x42)
[565.262929] Starting subtest: cursor-random-128x42
[565.312700] Subtest cursor-random-128x42: SKIP (0.042s)
[565.517535] [095/134] (463s left) kms_dp_link_training (non-uhbr-sst)
[565.612945] Starting subtest: non-uhbr-sst
[565.622930] Subtest non-uhbr-sst: SKIP (0.000s)
[565.695364] [096/134] (462s left) gem_exec_reloc (basic-gtt-noreloc)
[565.758558] Subtest basic-gtt-noreloc: SKIP (0.000s)
[565.851559] [097/134] (462s left) gem_exec_schedule (implicit-read-write)
[565.922929] Starting subtest: implicit-read-write
[565.924939] Starting dynamic subtest: rcs0
[566.025669] Dynamic subtest rcs0: SUCCESS (0.110s)
[566.037184] Starting dynamic subtest: vcs0
[566.109126] Dynamic subtest vcs0: SUCCESS (0.082s)
[566.120475] Starting dynamic subtest: vcs1
[566.186737] Dynamic subtest vcs1: SUCCESS (0.077s)
[566.195514] Starting dynamic subtest: vecs0
[566.270120] Dynamic subtest vecs0: SUCCESS (0.082s)
[566.281423] Starting dynamic subtest: ccs0
[566.361452] Dynamic subtest ccs0: SUCCESS (0.090s)
[566.364045] Subtest implicit-read-write: SUCCESS (0.447s)
[567.275039] [098/134] (461s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[567.335850] Starting subtest: yf-tiled-to-vebox-x-tiled
[567.341144] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[567.528210] [099/134] (461s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[567.628782] Starting subtest: 2x-absolute-wf_vblank-interruptible
[567.640858] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[567.725531] [100/134] (460s left) gem_exec_balancer (smoke)
[567.797158] Starting subtest: smoke
[590.351129] Subtest smoke: SUCCESS (22.554s)
[592.354927] [101/134] (436s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[592.411156] Starting subtest: etime-single-wait-all-for-submit-submitted
[592.518405] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[592.613396] [102/134] (436s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-cpu)
[592.720165] Starting subtest: fbcpsr-abgr161616f-draw-mmap-cpu
[592.724971] Subtest fbcpsr-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[592.826229] [103/134] (436s left) kms_psr (fbc-pr-primary-mmap-cpu)
[592.928761] Starting subtest: fbc-pr-primary-mmap-cpu
[592.933655] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[593.014302] [104/134] (435s left) api_intel_bb (blit-noreloc-purge-cache)
[593.064838] Starting subtest: blit-noreloc-purge-cache
[593.075080] Subtest blit-noreloc-purge-cache: SUCCESS (0.013s)
[593.211113] [105/134] (435s left) gem_lmem_swapping (massive)
[593.252991] Subtest massive: SKIP (0.000s)
[593.294724] [106/134] (435s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[593.396589] Starting subtest: fbc-rgb101010-draw-pwrite
[598.733273] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.342s)
[599.930719] [107/134] (429s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[600.042406] Starting subtest: yf-tiled-8bpp-rotate-90
[600.047726] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[600.139591] [108/134] (428s left) syncobj_timeline (invalid-signal-bad-pad)
[600.195854] Starting subtest: invalid-signal-bad-pad
[600.198163] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[600.313176] [109/134] (428s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[600.707946] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[601.526406] [110/134] (427s left) syncobj_eventfd (timeline-wait-signaled)
[601.592000] Starting subtest: timeline-wait-signaled
[601.595050] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[601.712910] [111/134] (427s left) kms_flip (flip-vs-absolute-wf_vblank)
[601.811114] Starting subtest: flip-vs-absolute-wf_vblank
[601.813940] Starting dynamic subtest: A-eDP1
[610.706521] Dynamic subtest A-eDP1: SUCCESS (8.894s)
[610.717811] Starting dynamic subtest: B-eDP1
[619.641953] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[619.653766] Starting dynamic subtest: C-eDP1
[628.561772] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[628.571209] Starting dynamic subtest: D-eDP1
[637.496337] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[637.501896] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.684s)
[638.735428] [112/134] (390s left) kms_psr (fbc-psr-sprite-plane-move)
[638.827882] Starting subtest: fbc-psr-sprite-plane-move
[638.830212] Starting dynamic subtest: eDP-1
[638.835624] Dynamic subtest eDP-1: SKIP (0.000s)
[638.841014] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[638.913481] [113/134] (390s left) kms_cursor_crc (cursor-sliding-256x256)
[639.171971] Starting subtest: cursor-sliding-256x256
[639.177711] Starting dynamic subtest: pipe-A-eDP-1
[642.395986] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.218s)
[642.433964] Starting dynamic subtest: pipe-D-eDP-1
[646.317003] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.889s)
[646.320244] Subtest cursor-sliding-256x256: SUCCESS (7.142s)
[647.200668] [114/134] (382s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[647.312376] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[647.317615] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[647.442485] [115/134] (381s left) gem_eio (in-flight-external)
[647.669770] Starting subtest: in-flight-external
[649.237322] Subtest in-flight-external: SUCCESS (1.566s)
[649.407342] [116/134] (379s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[649.517488] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[649.523126] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[649.644643] [117/134] (379s left) kms_setmode (invalid-clone-single-crtc-stealing)
[649.704495] Starting subtest: invalid-clone-single-crtc-stealing
[649.711778] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[649.825657] [118/134] (379s left) api_intel_bb (misplaced-blitter)
[649.883081] Starting subtest: misplaced-blitter
[649.888687] Subtest misplaced-blitter: SUCCESS (0.008s)
[650.038379] [119/134] (379s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[655.056612] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[655.061720] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[655.916430] [120/134] (373s left) i915_pm_rpm (gem-idle)
[657.448712] Starting subtest: gem-idle
[663.653969] Subtest gem-idle: SUCCESS (6.207s)
[663.997485] [121/134] (365s left) gem_exec_fence (syncobj-unused-fence)
[665.530682] Starting subtest: syncobj-unused-fence
[665.536845] Subtest syncobj-unused-fence: SUCCESS (0.006s)
[667.240132] [122/134] (362s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[667.304025] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[667.386384] [123/134] (362s left) kms_pm_rpm (legacy-planes-dpms)
[669.322592] Starting subtest: legacy-planes-dpms
[669.324793] Starting dynamic subtest: plane-64
[677.619626] Dynamic subtest plane-64: SUCCESS (8.296s)
[677.632163] Starting dynamic subtest: plane-94
[685.914482] Dynamic subtest plane-94: SUCCESS (8.289s)
[685.927116] Starting dynamic subtest: plane-124
[694.240848] Dynamic subtest plane-124: SUCCESS (8.325s)
[694.252593] Starting dynamic subtest: plane-134
[702.868716] Dynamic subtest plane-134: SUCCESS (8.627s)
[702.871677] Subtest legacy-planes-dpms: SUCCESS (33.549s)
[703.265898] [124/134] (326s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[703.364975] Starting subtest: fbcpsr-2p-rte
[703.370876] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[703.483014] [125/134] (326s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[703.585315] Starting subtest: psr-1p-primscrn-spr-indfb-move
[711.079381] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.497s)
[711.256742] [126/134] (318s left) gem_exec_reloc (basic-cpu-read)
[711.324019] Subtest basic-cpu-read: SKIP (0.000s)
[711.409802] [127/134] (318s left) kms_psr (pr-cursor-plane-move)
[711.511363] Starting subtest: pr-cursor-plane-move
[711.515881] Subtest pr-cursor-plane-move: SKIP (0.000s)
[711.598806] [128/134] (318s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[711.713405] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[715.425674] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.719s)
[716.593621] [129/134] (313s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[716.694702] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[717.762743] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.068s)
[717.883765] [130/134] (312s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[717.992566] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[717.994770] Starting dynamic subtest: A-eDP1
[721.605920] Dynamic subtest A-eDP1: SUCCESS (3.610s)
[721.616775] Starting dynamic subtest: B-eDP1
[724.786022] Dynamic subtest B-eDP1: SUCCESS (3.181s)
[724.797044] Starting dynamic subtest: C-eDP1
[727.889853] Dynamic subtest C-eDP1: SUCCESS (3.103s)
[727.899789] Starting dynamic subtest: D-eDP1
[731.003279] Dynamic subtest D-eDP1: SUCCESS (3.111s)
[731.007416] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.011s)
[731.817246] [131/134] (298s left) prime_mmap_coherency (ioctl-errors)
[731.889047] Starting subtest: ioctl-errors
[756.677764] Subtest ioctl-errors: SUCCESS (24.788s)
[756.856639] [132/134] (273s left) kms_addfb_basic (unused-offsets)
[756.952154] Starting subtest: unused-offsets
[756.954806] Subtest unused-offsets: SUCCESS (0.000s)
[757.122477] [133/134] (272s left) i915_suspend (debugfs-reader)
[757.180877] Starting subtest: debugfs-reader
[775.772649] Subtest debugfs-reader: SUCCESS (3.204s)
[775.936921] [134/134] (254s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[776.039210] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[776.041334] Starting dynamic subtest: pipe-A-eDP-1
[776.097312] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[776.107598] Starting dynamic subtest: pipe-B-eDP-1
[776.156353] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.059s)
[776.166323] Starting dynamic subtest: pipe-C-eDP-1
[776.216437] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.059s)
[776.226061] Starting dynamic subtest: pipe-D-eDP-1
[776.276405] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.057s)
[776.279203] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.239s)
[778.513958] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: kms_lease
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_vrr
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: gem_ctx_create
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_suspend
results: parsing output: 14/ for test: gem_exec_params
results: parsing output: 15/ for test: gem_caching
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: kms_pm_backlight
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_async_flips
results: parsing output: 22/ for test: kms_vblank
results: parsing output: 23/ for test: gem_exec_params
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: dmabuf_sync_file
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: kms_content_protection
results: parsing output: 32/ for test: kms_atomic_transition
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_plane
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_draw_crc
results: parsing output: 38/ for test: kms_hdr
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: sw_sync
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: gem_exec_fence
results: parsing output: 45/ for test: gem_ctx_persistence
results: parsing output: 46/ for test: kms_plane_alpha_blend
results: parsing output: 47/ for test: gem_pxp
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_atomic_transition
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_partial_pwrite_pread
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: kms_plane
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: gem_exec_async
results: parsing output: 56/ for test: kms_prop_blob
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_create
results: parsing output: 59/ for test: kms_pipe_crc_basic
results: parsing output: 60/ for test: kms_rmfb
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_chamelium_edid
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: i915_module_load
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: gem_pxp
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: i915_drm_fdinfo
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: fbdev
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: gem_create
results: parsing output: 84/ for test: sysfs_timeslice_duration
results: parsing output: 85/ for test: kms_pipe_b_c_ivb
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: gem_vm_create
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_pm_rpm
results: parsing output: 92/ for test: kms_color
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_dp_link_training
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: gem_lmem_swapping
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_chamelium_hpd
results: parsing output: 109/ for test: syncobj_eventfd
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_eio
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_setmode
results: parsing output: 117/ for test: api_intel_bb
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: gem_exec_fence
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: prime_mmap_coherency
results: parsing output: 131/ for test: kms_addfb_basic
results: parsing output: 132/ for test: i915_suspend
results: parsing output: 133/ for test: kms_ccs
Done.