[56.868555] Initializing watchdogs
[56.868600]   /dev/watchdog0
[56.884225] [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]
[56.888652] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.891029] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.894435] [001/133] (960s left) gem_userptr_blits (nohangcheck)
[56.993385] Starting subtest: nohangcheck
[57.319758] Subtest nohangcheck: SUCCESS (0.332s)
[57.426880] [002/133] (960s left) gem_request_retire (retire-vma-not-inactive)
[57.472995] Starting subtest: retire-vma-not-inactive
[57.531713] Subtest retire-vma-not-inactive: SUCCESS (0.059s)
[57.644439] [003/133] (959s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[57.694835] Starting subtest: single-wait-for-submit-available-signaled
[57.697114] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[57.785186] [004/133] (959s left) kms_prime (basic-modeset-hybrid)
[57.876969] Subtest basic-modeset-hybrid: SKIP (0.000s)
[57.980439] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[57.983695] [005/133] (959s left) gem_render_copy (linear-to-vebox-yf-tiled)
[58.052232] Starting subtest: linear-to-vebox-yf-tiled
[58.056919] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[58.248789] [006/133] (959s left) kms_cursor_crc (cursor-sliding-128x42)
[58.465893] Starting subtest: cursor-sliding-128x42
[58.520467] Subtest cursor-sliding-128x42: SKIP (0.051s)
[58.709264] [007/133] (958s left) kms_psr (psr2-cursor-plane-move)
[58.808747] Starting subtest: psr2-cursor-plane-move
[58.811062] Starting dynamic subtest: eDP-1
[60.549267] Dynamic subtest eDP-1: SUCCESS (1.751s)
[60.551164] Subtest psr2-cursor-plane-move: SUCCESS (1.752s)
[61.440173] [008/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[61.532628] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[61.536855] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[61.629193] [009/133] (956s left) perf_pmu (rc6-all-gts)
[61.669584] Starting subtest: rc6-all-gts
[68.038217] Subtest rc6-all-gts: SUCCESS (6.388s)
[68.960837] [010/133] (948s left) gem_mmap_offset (partial-mmap)
[69.012822] Starting subtest: partial-mmap
[69.015129] Starting dynamic subtest: smem0
[69.017420] Dynamic subtest smem0: SUCCESS (0.006s)
[69.019838] Subtest partial-mmap: SUCCESS (0.007s)
[69.124642] [011/133] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[69.230802] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[77.896117] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.678s)
[78.030595] [012/133] (939s left) perf (non-system-wide-paranoid)
[78.152067] Starting subtest: non-system-wide-paranoid
[78.181703] Subtest non-system-wide-paranoid: SUCCESS (0.030s)
[78.232200] [013/133] (939s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[78.334793] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[78.339252] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[78.433046] [014/133] (939s left) i915_hangman (detector)
[78.499045] Starting subtest: detector
[78.501411] Starting dynamic subtest: rcs0
[88.883554] Dynamic subtest rcs0: SUCCESS (10.380s)
[88.894208] Starting dynamic subtest: bcs0
[100.851231] Dynamic subtest bcs0: SUCCESS (11.965s)
[100.861642] Starting dynamic subtest: vcs0
[112.883818] Dynamic subtest vcs0: SUCCESS (12.030s)
[112.894441] Starting dynamic subtest: vcs1
[124.851405] Dynamic subtest vcs1: SUCCESS (11.966s)
[124.864190] Starting dynamic subtest: vecs0
[136.819840] Dynamic subtest vecs0: SUCCESS (11.967s)
[136.830295] Starting dynamic subtest: ccs0
[146.868037] Dynamic subtest ccs0: SUCCESS (10.046s)
[146.870854] Subtest detector: SUCCESS (68.362s)
[146.957053] [015/133] (871s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[147.048167] Starting subtest: plane-lut1d-ctm3x4-lut1d
[147.194527] Starting dynamic subtest: pipe-A-plane-0
[147.580717] Dynamic subtest pipe-A-plane-0: FAIL (0.206s)
[147.590331] Starting dynamic subtest: pipe-A-plane-1
[147.819044] Dynamic subtest pipe-A-plane-1: FAIL (0.169s)
[147.828160] Starting dynamic subtest: pipe-A-plane-2
[148.052079] Dynamic subtest pipe-A-plane-2: FAIL (0.189s)
[149.011513] Starting dynamic subtest: pipe-B-plane-0
[149.453622] Dynamic subtest pipe-B-plane-0: FAIL (0.176s)
[149.461519] Starting dynamic subtest: pipe-B-plane-1
[149.779420] Dynamic subtest pipe-B-plane-1: FAIL (0.176s)
[149.788652] Starting dynamic subtest: pipe-B-plane-2
[150.094636] Dynamic subtest pipe-B-plane-2: FAIL (0.178s)
[150.728209] Starting dynamic subtest: pipe-C-plane-0
[151.260302] Dynamic subtest pipe-C-plane-0: FAIL (0.151s)
[151.270058] Starting dynamic subtest: pipe-C-plane-1
[151.681396] Dynamic subtest pipe-C-plane-1: FAIL (0.618s)
[151.690510] Starting dynamic subtest: pipe-C-plane-2
[152.073324] Dynamic subtest pipe-C-plane-2: FAIL (0.161s)
[152.884794] Starting dynamic subtest: pipe-D-plane-0
[153.514261] Dynamic subtest pipe-D-plane-0: FAIL (0.163s)
[153.524457] Starting dynamic subtest: pipe-D-plane-1
[153.981693] Dynamic subtest pipe-D-plane-1: FAIL (0.610s)
[153.990247] Starting dynamic subtest: pipe-D-plane-2
[154.443423] Dynamic subtest pipe-D-plane-2: FAIL (0.539s)
[154.483292] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (7.435s)
[155.359700] [016/133] (862s left) gem_exec_nop (basic-sequential)
[155.437772] Starting subtest: basic-sequential
[171.994976] Subtest basic-sequential: SUCCESS (16.565s)
[172.242793] [017/133] (845s left) prime_self_import (basic-llseek-size)
[172.277938] Starting subtest: basic-llseek-size
[172.299929] Subtest basic-llseek-size: SUCCESS (0.021s)
[172.422214] [018/133] (845s left) core_getclient (basic)
[172.487682] Starting subtest: basic
[172.489899] Subtest basic: SUCCESS (0.000s)
[172.608663] [019/133] (845s left) kms_flip (basic-flip-vs-dpms)
[172.701378] Starting subtest: basic-flip-vs-dpms
[172.703711] Starting dynamic subtest: A-eDP1
[175.345592] Dynamic subtest A-eDP1: SUCCESS (2.641s)
[175.353959] Starting dynamic subtest: B-eDP1
[177.512633] Dynamic subtest B-eDP1: SUCCESS (2.166s)
[177.520810] Starting dynamic subtest: C-eDP1
[179.587459] Dynamic subtest C-eDP1: SUCCESS (2.074s)
[179.597062] Starting dynamic subtest: D-eDP1
[181.665803] Dynamic subtest D-eDP1: SUCCESS (2.077s)
[181.667841] Subtest basic-flip-vs-dpms: SUCCESS (8.968s)
[182.468415] [020/133] (835s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[182.570378] Starting subtest: fbc-psr2-sprite-mmap-cpu
[182.572615] Starting dynamic subtest: eDP-1
[182.576692] Dynamic subtest eDP-1: SKIP (0.000s)
[182.580809] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[182.647249] [021/133] (835s left) syncobj_wait (invalid-signal-zero-handles)
[182.696695] Starting subtest: invalid-signal-zero-handles
[182.698572] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[182.800603] [022/133] (835s left) i915_suspend (basic-s2idle-without-i915)
[182.833678] Starting subtest: basic-s2idle-without-i915
[202.306246] Subtest basic-s2idle-without-i915: SUCCESS (4.504s)
[208.460753] [023/133] (815s left) kms_content_protection (type1)
[208.645630] Starting subtest: type1
[208.649848] Subtest type1: SKIP (0.000s)
[208.748481] [024/133] (815s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[208.838156] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[208.840390] Starting dynamic subtest: pipe-A-eDP-1
[208.862620] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[208.872291] Starting dynamic subtest: pipe-B-eDP-1
[208.893084] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[208.900723] Starting dynamic subtest: pipe-C-eDP-1
[208.921040] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[208.928505] Starting dynamic subtest: pipe-D-eDP-1
[208.949208] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[208.953085] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[211.090922] [025/133] (813s left) gem_basic (create-fd-close)
[211.159798] Starting subtest: create-fd-close
[211.164828] Subtest create-fd-close: SUCCESS (0.000s)
[211.252213] [026/133] (813s left) kms_plane (plane-position-hole)
[211.343177] Starting subtest: plane-position-hole
[211.857951] Starting dynamic subtest: pipe-A-plane-1
[213.128497] Dynamic subtest pipe-A-plane-1: SUCCESS (1.298s)
[213.138132] Starting dynamic subtest: pipe-A-plane-2
[214.452808] Dynamic subtest pipe-A-plane-2: SUCCESS (1.349s)
[214.462288] Starting dynamic subtest: pipe-A-plane-3
[215.747621] Dynamic subtest pipe-A-plane-3: SUCCESS (1.314s)
[215.756446] Starting dynamic subtest: pipe-A-plane-4
[217.044509] Dynamic subtest pipe-A-plane-4: SUCCESS (1.312s)
[217.053943] Starting dynamic subtest: pipe-A-plane-5
[217.069311] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[218.298614] Starting dynamic subtest: pipe-B-plane-1
[219.602095] Dynamic subtest pipe-B-plane-1: SUCCESS (1.322s)
[219.610945] Starting dynamic subtest: pipe-B-plane-2
[220.946162] Dynamic subtest pipe-B-plane-2: SUCCESS (1.357s)
[220.956700] Starting dynamic subtest: pipe-B-plane-3
[222.278343] Dynamic subtest pipe-B-plane-3: SUCCESS (1.339s)
[222.287156] Starting dynamic subtest: pipe-B-plane-4
[223.660186] Dynamic subtest pipe-B-plane-4: SUCCESS (1.386s)
[223.673304] Starting dynamic subtest: pipe-B-plane-5
[223.685309] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[223.687760] Subtest plane-position-hole: SUCCESS (12.495s)
[224.467759] [027/133] (800s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[224.570848] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[224.573106] Starting dynamic subtest: pipe-A-eDP-1
[224.632417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[224.943241] Starting dynamic subtest: pipe-B-eDP-1
[225.757062] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.827s)
[226.056185] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.493s)
[226.921085] [028/133] (797s left) kms_plane_cursor (primary)
[227.007785] Starting subtest: primary
[227.012167] Starting dynamic subtest: pipe-A-eDP-1-size-64
[229.606310] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.607s)
[229.629853] Starting dynamic subtest: pipe-A-eDP-1-size-128
[232.199964] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s)
[232.224403] Starting dynamic subtest: pipe-A-eDP-1-size-256
[234.808596] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.594s)
[235.124727] Starting dynamic subtest: pipe-B-eDP-1-size-64
[238.394020] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.280s)
[238.417716] Starting dynamic subtest: pipe-B-eDP-1-size-128
[241.020226] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.605s)
[241.043052] Starting dynamic subtest: pipe-B-eDP-1-size-256
[243.609534] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.572s)
[243.931150] Starting dynamic subtest: pipe-C-eDP-1-size-64
[246.867496] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.944s)
[246.893741] Starting dynamic subtest: pipe-C-eDP-1-size-128
[249.091055] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[249.115332] Starting dynamic subtest: pipe-C-eDP-1-size-256
[251.301161] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.191s)
[251.620532] Starting dynamic subtest: pipe-D-eDP-1-size-64
[254.582471] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.973s)
[254.609624] Starting dynamic subtest: pipe-D-eDP-1-size-128
[256.826162] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.225s)
[256.852067] Starting dynamic subtest: pipe-D-eDP-1-size-256
[259.026283] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[259.335119] Subtest primary: SUCCESS (32.345s)
[260.133596] [029/133] (764s left) perf (invalid-oa-exponent)
[260.265728] Starting subtest: invalid-oa-exponent
[260.282555] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[260.332544] [030/133] (764s left) gem_mmap_gtt (big-bo-tiledy)
[260.381437] Subtest big-bo-tiledY: SKIP (0.000s)
[260.442769] [031/133] (764s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[260.545142] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[260.549573] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[260.655393] [032/133] (764s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[260.760638] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[260.765077] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[260.845685] [033/133] (763s left) gem_exec_whisper (basic-contexts-forked)
[260.923361] Starting subtest: basic-contexts-forked
[284.530066] Subtest basic-contexts-forked: SUCCESS (23.612s)
[284.711460] [034/133] (740s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[284.803534] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[284.805871] Starting dynamic subtest: pipe-A
[284.869215] Dynamic subtest pipe-A: SUCCESS (0.068s)
[284.879555] Starting dynamic subtest: pipe-B
[286.042883] Dynamic subtest pipe-B: SUCCESS (1.173s)
[286.054123] Starting dynamic subtest: pipe-C
[287.155989] Dynamic subtest pipe-C: SUCCESS (1.112s)
[287.164665] Starting dynamic subtest: pipe-D
[288.307306] Dynamic subtest pipe-D: SUCCESS (1.151s)
[288.309692] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.508s)
[289.469935] [035/133] (735s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[289.525274] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[289.527193] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[289.639339] [036/133] (735s left) kms_psr (fbc-psr2-sprite-render)
[289.725823] Starting subtest: fbc-psr2-sprite-render
[289.728104] Starting dynamic subtest: eDP-1
[289.732194] Dynamic subtest eDP-1: SKIP (0.000s)
[289.736228] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[289.799946] [037/133] (735s left) gem_ctx_persistence (heartbeat-hang)
[289.862595] Starting subtest: heartbeat-hang
[289.867308] Subtest heartbeat-hang: SKIP (0.000s)
[289.962444] [038/133] (734s left) api_intel_bb (blit-noreloc-purge-cache)
[290.015807] Starting subtest: blit-noreloc-purge-cache
[290.024126] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[290.134804] [039/133] (734s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[290.229162] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[290.233096] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[290.335235] [040/133] (734s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[290.427388] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[297.784036] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.364s)
[297.913228] [041/133] (727s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[297.959662] Starting subtest: invalid-single-wait-all-unsubmitted
[297.961538] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[298.047877] [042/133] (727s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[298.110537] Starting subtest: yf-tiled-to-vebox-x-tiled
[298.115072] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[298.294275] [043/133] (726s left) gem_exec_reloc (basic-cpu-read-noreloc)
[298.349912] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[298.430483] [044/133] (726s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[298.520968] Starting subtest: fbcpsr-slowdraw
[323.720838] Subtest fbcpsr-slowdraw: SUCCESS (25.198s)
[323.881965] [045/133] (701s left) gem_mmap_gtt (cpuset-basic-small-copy)
[323.954517] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[324.011078] [046/133] (701s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[324.111457] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[324.124594] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[324.210945] [047/133] (701s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[324.298957] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[324.301229] Starting dynamic subtest: pipe-A-eDP-1
[341.081136] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s)
[341.091140] Starting dynamic subtest: pipe-B-eDP-1
[359.061653] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.861s)
[359.071538] Starting dynamic subtest: pipe-C-eDP-1
[376.994166] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.792s)
[377.003517] Starting dynamic subtest: pipe-D-eDP-1
[395.020909] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[395.023186] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.242s)
[402.269611] [048/133] (629s left) kms_prop_blob (invalid-get-prop)
[402.339380] Starting subtest: invalid-get-prop
[402.341567] Subtest invalid-get-prop: SUCCESS (0.000s)
[402.439237] [049/133] (629s left) gem_pipe_control_store_loop (reused-buffer)
[402.498273] Starting subtest: reused-buffer
[404.583489] Subtest reused-buffer: SUCCESS (2.152s)
[404.686784] [050/133] (626s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[404.784013] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[404.788601] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[404.866476] [051/133] (626s left) kms_pm_dc (dc9-dpms)
[405.961039] Starting subtest: dc9-dpms
[407.373990] Subtest dc9-dpms: SUCCESS (1.443s)
[407.437182] [052/133] (624s left) kms_psr (pr-sprite-render)
[407.533065] Starting subtest: pr-sprite-render
[407.537359] Subtest pr-sprite-render: SKIP (0.000s)
[407.605205] [053/133] (624s left) gem_exec_schedule (smoketest-all)
[407.674069] Starting subtest: smoketest-all
[439.904108] Subtest smoketest-all: SUCCESS (32.324s)
[441.460035] [054/133] (590s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[441.574643] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[441.576816] Starting dynamic subtest: pipe-A-eDP-1
[447.564685] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.988s)
[447.574403] Starting dynamic subtest: pipe-B-eDP-1
[454.225615] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.660s)
[454.228085] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.652s)
[455.106737] [055/133] (576s left) kms_cursor_crc (cursor-offscreen-256x85)
[455.365082] Starting subtest: cursor-offscreen-256x85
[455.411986] Subtest cursor-offscreen-256x85: SKIP (0.043s)
[455.604690] [056/133] (576s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[455.695441] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[459.679479] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.987s)
[460.810023] [057/133] (570s left) gen3_render_tiledx_blits
[460.924256] [058/133] (570s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[461.020987] Starting subtest: pr-plane-move-sf-dmg-area
[461.025133] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[461.110587] [059/133] (570s left) syncobj_eventfd (timeline-wait)
[461.158913] Starting subtest: timeline-wait
[461.166914] Subtest timeline-wait: SUCCESS (0.010s)
[461.251930] [060/133] (570s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[461.351110] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[461.355245] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[461.444399] [061/133] (570s left) kms_atomic (crtc-invalid-params)
[461.543953] Starting subtest: crtc-invalid-params
[461.546136] Starting dynamic subtest: pipe-A-eDP-1
[461.905969] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s)
[461.908188] Subtest crtc-invalid-params: SUCCESS (0.364s)
[462.728356] [062/133] (569s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[462.792511] Starting subtest: etime-single-wait-for-submit-unsubmitted
[462.894348] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[462.971856] [063/133] (569s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[463.074083] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[463.720216] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[463.894812] [064/133] (568s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[463.980970] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[464.016203] Starting dynamic subtest: pipe-A-plane-0
[464.303784] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[464.317331] Starting dynamic subtest: pipe-A-plane-3
[464.537202] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[464.547186] Starting dynamic subtest: pipe-A-plane-5
[464.551317] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[465.617493] Starting dynamic subtest: pipe-B-plane-0
[465.911966] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[465.931523] Starting dynamic subtest: pipe-B-plane-3
[466.154769] Dynamic subtest pipe-B-plane-3: SUCCESS (0.242s)
[466.164152] Starting dynamic subtest: pipe-B-plane-5
[466.169408] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[466.466954] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.484s)
[467.290182] [065/133] (564s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[467.395860] Starting subtest: primary-y-tiled-reflect-x-0
[467.472913] Subtest primary-y-tiled-reflect-x-0: SKIP (0.075s)
[467.589543] [066/133] (564s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[467.685926] Starting subtest: fbc-rgb565-draw-mmap-gtt
[467.689765] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[467.777803] [067/133] (564s left) gem_ppgtt (shrink-vs-evict-pinned)
[467.835711] Starting subtest: shrink-vs-evict-pinned
[473.378545] Subtest shrink-vs-evict-pinned: SUCCESS (5.542s)
[473.475901] [068/133] (558s left) gem_exec_capture (userptr)
[473.551981] Starting subtest: userptr
[474.372982] Subtest userptr: SUCCESS (0.822s)
[474.494358] [069/133] (557s left) kms_dp_linktrain_fallback (dp-fallback)
[474.586976] Starting subtest: dp-fallback
[474.593224] Subtest dp-fallback: SKIP (0.000s)
[474.662347] [070/133] (557s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[474.766823] Starting subtest: 4-tiled-8bpp-rotate-90
[474.790498] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[474.901210] [071/133] (557s left) kms_pipe_crc_basic (suspend-read-crc)
[475.011120] Starting subtest: suspend-read-crc
[475.013381] Starting dynamic subtest: pipe-A-eDP-1
[493.790265] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.979s)
[493.801092] Starting dynamic subtest: pipe-B-eDP-1
[512.753406] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.597s)
[512.762646] Starting dynamic subtest: pipe-C-eDP-1
[531.709405] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.509s)
[531.719475] Starting dynamic subtest: pipe-D-eDP-1
[550.726815] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.472s)
[550.729099] Subtest suspend-read-crc: SUCCESS (13.564s)
[562.576639] [072/133] (480s left) perf (enable-disable)
[562.676120] Starting subtest: enable-disable
[562.678311] Starting dynamic subtest: 0-rcs0
[564.961069] Dynamic subtest 0-rcs0: SUCCESS (2.353s)
[564.970651] Starting dynamic subtest: 1-vcs0
[569.434559] Dynamic subtest 1-vcs0: SUCCESS (4.561s)
[569.437095] Subtest enable-disable: SUCCESS (6.915s)
[569.486153] [073/133] (474s left) perf_pmu (all-busy-idle-check-all)
[569.530252] Starting subtest: all-busy-idle-check-all
[570.222837] Subtest all-busy-idle-check-all: FAIL (0.631s)
[570.610189] [074/133] (472s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[570.713574] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[570.717746] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[570.816051] [075/133] (472s left) kms_invalid_mode (zero-clock)
[570.911469] Starting subtest: zero-clock
[570.913709] Starting dynamic subtest: pipe-A-eDP-1
[571.194677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[571.205317] Starting dynamic subtest: pipe-B-eDP-1
[571.207481] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[571.216407] Starting dynamic subtest: pipe-C-eDP-1
[571.218592] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[571.227462] Starting dynamic subtest: pipe-D-eDP-1
[571.229545] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[571.231649] Subtest zero-clock: SUCCESS (0.293s)
[572.063015] [076/133] (471s left) gem_madvise (dontneed-before-pwrite)
[572.105495] Starting subtest: dontneed-before-pwrite
[572.129343] Subtest dontneed-before-pwrite: SKIP (0.022s)
[572.192417] [077/133] (471s left) gem_exec_whisper (basic-queues-all)
[572.255019] Starting subtest: basic-queues-all
[583.482220] Subtest basic-queues-all: SUCCESS (11.285s)
[583.667180] [078/133] (460s left) kms_psr (psr-primary-render)
[583.760921] Starting subtest: psr-primary-render
[583.763128] Starting dynamic subtest: eDP-1
[585.500088] Dynamic subtest eDP-1: SUCCESS (1.744s)
[585.502338] Subtest psr-primary-render: SUCCESS (1.745s)
[586.355257] [079/133] (457s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[586.748167] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[587.573102] [080/133] (456s left) gem_bad_reloc (negative-reloc-lut)
[587.635007] Subtest negative-reloc-lut: SKIP (0.000s)
[587.712351] [081/133] (456s left) syncobj_wait (wait-any-snapshot)
[587.771860] Starting subtest: wait-any-snapshot
[587.852333] Subtest wait-any-snapshot: SUCCESS (0.082s)
[587.932464] [082/133] (455s left) i915_drm_fdinfo (virtual-busy-hang)
[587.977283] Starting subtest: virtual-busy-hang
[587.981852] Subtest virtual-busy-hang: SKIP (0.000s)
[588.039783] [083/133] (455s left) kms_selftest (drm_dp_mst_helper)
[588.077506] Starting subtest: drm_dp_mst_helper
[588.119431] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[588.219653] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.098s)
[588.229172] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[588.330520] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.110s)
[588.349806] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[588.440189] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.108s)
[588.442224] Subtest drm_dp_mst_helper: SUCCESS (0.363s)
[588.635104] [084/133] (455s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[588.725419] Starting subtest: async-flip-with-page-flip-events-tiled
[589.105605] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[591.858102] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.754s)
[591.868003] Starting dynamic subtest: pipe-A-eDP-1-4
[594.030285] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[594.040140] Starting dynamic subtest: pipe-A-eDP-1-4
[596.037429] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.005s)
[596.047063] Starting dynamic subtest: pipe-A-eDP-1-x
[598.228454] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.187s)
[598.597548] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[601.384786] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[601.400067] Starting dynamic subtest: pipe-B-eDP-1-4
[603.572176] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.183s)
[603.582005] Starting dynamic subtest: pipe-B-eDP-1-4
[605.582993] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[605.592773] Starting dynamic subtest: pipe-B-eDP-1-x
[607.808191] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.223s)
[608.175647] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[610.917406] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.748s)
[610.926928] Starting dynamic subtest: pipe-C-eDP-1-4
[613.092422] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[613.104570] Starting dynamic subtest: pipe-C-eDP-1-4
[615.103138] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[615.114927] Starting dynamic subtest: pipe-C-eDP-1-x
[617.281619] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[617.646121] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[620.448727] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.809s)
[620.458631] Starting dynamic subtest: pipe-D-eDP-1-4
[622.623038] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[622.634582] Starting dynamic subtest: pipe-D-eDP-1-4
[624.633275] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[624.644034] Starting dynamic subtest: pipe-D-eDP-1-x
[626.833413] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.200s)
[626.835946] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.106s)
[628.030721] [085/133] (416s left) gem_ctx_param (invalid-get-engines)
[628.088050] Starting subtest: invalid-get-engines
[628.090397] Subtest invalid-get-engines: SUCCESS (0.001s)
[628.199286] [086/133] (415s left) core_setmaster (master-drop-set-shared-fd)
[628.281913] Starting subtest: master-drop-set-shared-fd
[628.303371] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[628.342737] [087/133] (415s left) prime_mmap (test_refcounting)
[628.400442] Starting subtest: test_refcounting
[628.402787] Starting dynamic subtest: test_refcounting-smem
[628.433900] Dynamic subtest test_refcounting-smem: SUCCESS (0.034s)
[628.436820] Subtest test_refcounting: SUCCESS (0.035s)
[628.551564] [088/133] (415s left) gen7_exec_parse (cmd-crossing-page)
[628.606106] Subtest cmd-crossing-page: SKIP (0.000s)
[628.677726] [089/133] (415s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[628.771924] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[628.776059] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[628.856626] [090/133] (415s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[628.951040] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[635.624053] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.675s)
[635.739045] [091/133] (408s left) kms_rotation_crc (sprite-rotation-90)
[635.836380] Starting subtest: sprite-rotation-90
[635.840828] Subtest sprite-rotation-90: SKIP (0.001s)
[635.925829] [092/133] (408s left) gem_exec_reloc (basic-write-cpu)
[635.993205] Subtest basic-write-cpu: SKIP (0.000s)
[636.060183] [093/133] (408s left) kms_chamelium_hpd (hdmi-hpd-fast)
[636.453449] Subtest hdmi-hpd-fast: SKIP (0.000s)
[637.247144] [094/133] (407s left) gem_ctx_shared (q-independent)
[637.310517] Starting subtest: Q-independent
[637.312816] Starting dynamic subtest: rcs0
[637.379630] Dynamic subtest rcs0: SUCCESS (0.068s)
[637.390899] Starting dynamic subtest: vcs0
[637.421356] Dynamic subtest vcs0: SUCCESS (0.041s)
[637.430434] Starting dynamic subtest: vcs1
[637.466376] Dynamic subtest vcs1: SUCCESS (0.044s)
[637.477294] Starting dynamic subtest: vecs0
[637.513961] Dynamic subtest vecs0: SUCCESS (0.046s)
[637.525990] Starting dynamic subtest: ccs0
[637.587406] Dynamic subtest ccs0: SUCCESS (0.073s)
[637.590021] Subtest Q-independent: SUCCESS (0.277s)
[638.577613] [095/133] (405s left) gem_spin_batch (user-each)
[638.652590] Starting subtest: user-each
[641.924098] Subtest user-each: SUCCESS (3.264s)
[642.551415] [096/133] (401s left) syncobj_wait (invalid-signal-illegal-handle)
[642.607414] Starting subtest: invalid-signal-illegal-handle
[642.609799] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[642.699684] [097/133] (401s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[642.791708] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[646.381552] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.594s)
[647.575770] [098/133] (397s left) gem_exec_fence (syncobj-timeline-unused-fence)
[648.135415] Starting subtest: syncobj-timeline-unused-fence
[648.137826] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[649.606090] [099/133] (395s left) gem_ctx_engines (independent)
[649.657783] Starting subtest: independent
[649.660032] Starting dynamic subtest: rcs0
[649.793820] Dynamic subtest rcs0: SUCCESS (0.134s)
[649.805755] Starting dynamic subtest: bcs0
[649.903057] Dynamic subtest bcs0: SUCCESS (0.109s)
[649.914761] Starting dynamic subtest: vcs0
[650.031900] Dynamic subtest vcs0: SUCCESS (0.127s)
[650.044198] Starting dynamic subtest: vcs1
[650.243170] Dynamic subtest vcs1: SUCCESS (0.210s)
[650.255653] Starting dynamic subtest: vecs0
[650.483068] Dynamic subtest vecs0: SUCCESS (0.239s)
[650.498634] Starting dynamic subtest: ccs0
[650.722191] Dynamic subtest ccs0: SUCCESS (0.239s)
[650.735456] Starting dynamic subtest: all-engines
[652.064980] Dynamic subtest all-engines: SUCCESS (1.342s)
[652.067394] Subtest independent: SUCCESS (2.407s)
[653.585197] [100/133] (391s left) gem_exec_schedule (preempt-queue-contexts-chain)
[653.659883] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[653.951009] [101/133] (390s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[654.067342] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[654.069710] Starting dynamic subtest: pipe-A-eDP-1
[654.356551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.260s)
[654.368012] Starting dynamic subtest: pipe-B-eDP-1
[655.664707] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.306s)
[655.676703] Starting dynamic subtest: pipe-C-eDP-1
[656.964013] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s)
[656.975655] Starting dynamic subtest: pipe-D-eDP-1
[658.196704] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[658.198917] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.103s)
[659.305017] [102/133] (385s left) syncobj_wait (multi-wait-for-submit-signaled)
[659.363075] Starting subtest: multi-wait-for-submit-signaled
[659.365383] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[659.463524] [103/133] (385s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[659.567213] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[659.571587] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[659.670410] [104/133] (385s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[659.797000] Starting subtest: cursorB-vs-flipA-legacy
[659.801545] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[659.945928] [105/133] (384s left) perf (non-zero-reason)
[660.039000] Starting subtest: non-zero-reason
[660.041288] Starting dynamic subtest: 0-rcs0
[665.503652] Dynamic subtest 0-rcs0: SUCCESS (5.461s)
[665.516074] Starting dynamic subtest: 1-vcs0
[669.438666] Dynamic subtest 1-vcs0: SUCCESS (3.932s)
[669.441341] Subtest non-zero-reason: SUCCESS (9.395s)
[669.486582] [106/133] (375s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[669.587492] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[669.591907] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[669.678292] [107/133] (375s left) gem_exec_fence (syncobj-invalid-flags)
[670.121655] Starting subtest: syncobj-invalid-flags
[670.124101] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[671.573810] [108/133] (373s left) kms_addfb_basic (invalid-get-prop-any)
[671.637813] Starting subtest: invalid-get-prop-any
[671.639806] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[671.782852] [109/133] (373s left) gem_mmap_wc (write-gtt-read-wc)
[671.841047] Subtest write-gtt-read-wc: SKIP (0.000s)
[671.901495] [110/133] (373s left) gem_exec_schedule (preempt-queue)
[671.977891] Subtest preempt-queue: SKIP (0.000s)
[672.274848] [111/133] (372s left) kms_vblank (query-forked-busy)
[672.362123] Starting subtest: query-forked-busy
[672.364339] Starting dynamic subtest: pipe-A-eDP-1
[674.237059] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[674.251445] Starting dynamic subtest: pipe-D-eDP-1
[676.761906] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.524s)
[676.764421] Subtest query-forked-busy: SUCCESS (4.401s)
[677.567569] [112/133] (367s left) prime_busy (after)
[677.621932] Starting subtest: after
[677.628214] Starting dynamic subtest: rcs0
[677.665034] Dynamic subtest rcs0: SUCCESS (0.037s)
[677.676147] Starting dynamic subtest: bcs0
[677.714379] Dynamic subtest bcs0: SUCCESS (0.049s)
[677.724821] Starting dynamic subtest: vcs0
[677.754946] Dynamic subtest vcs0: SUCCESS (0.040s)
[677.764627] Starting dynamic subtest: vcs1
[677.796363] Dynamic subtest vcs1: SUCCESS (0.040s)
[677.806365] Starting dynamic subtest: vecs0
[677.836362] Dynamic subtest vecs0: SUCCESS (0.039s)
[677.845841] Starting dynamic subtest: ccs0
[677.877144] Dynamic subtest ccs0: SUCCESS (0.040s)
[677.986066] Subtest after: SUCCESS (0.362s)
[678.062971] [113/133] (367s left) kms_lease (lease-again)
[678.163235] Starting subtest: lease-again
[678.165580] Starting dynamic subtest: pipe-A-eDP-1
[678.167901] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[678.178974] Starting dynamic subtest: pipe-B-eDP-1
[678.181145] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[678.190926] Starting dynamic subtest: pipe-C-eDP-1
[678.193070] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[678.203039] Starting dynamic subtest: pipe-D-eDP-1
[678.205171] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[678.207360] Subtest lease-again: SUCCESS (0.015s)
[678.285846] [114/133] (367s left) kms_cursor_edge_walk (64x64-top-edge)
[678.378077] Starting subtest: 64x64-top-edge
[678.380441] Starting dynamic subtest: pipe-A-eDP-1
[681.835851] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.456s)
[681.846511] Starting dynamic subtest: pipe-D-eDP-1
[684.950890] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[684.953220] Subtest 64x64-top-edge: SUCCESS (6.575s)
[685.773170] [115/133] (359s left) i915_pm_rps (reset)
[685.837779] Starting subtest: reset
[694.284194] Subtest reset: SUCCESS (8.446s)
[694.422219] [116/133] (350s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[694.525231] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[694.529385] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[694.633971] [117/133] (350s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[694.693618] Starting subtest: multi-wait-for-submit-available-signaled
[694.695968] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[694.786784] [118/133] (350s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[694.871588] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[694.873389] Starting dynamic subtest: pipe-A-eDP-1
[695.296128] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s)
[695.308591] Starting dynamic subtest: pipe-B-eDP-1
[695.325717] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[695.335735] Starting dynamic subtest: pipe-C-eDP-1
[695.352181] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[695.362934] Starting dynamic subtest: pipe-D-eDP-1
[695.377912] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[695.379569] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.441s)
[697.637730] [119/133] (347s left) kms_big_fb (linear-8bpp-rotate-0)
[697.744023] Starting subtest: linear-8bpp-rotate-0
[698.995655] Subtest linear-8bpp-rotate-0: SUCCESS (1.252s)
[699.123305] [120/133] (346s left) kms_getfb (getfb2-handle-not-fb)
[699.217268] Starting subtest: getfb2-handle-not-fb
[699.219069] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[699.329417] [121/133] (346s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[699.424493] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[699.437060] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[699.515642] [122/133] (346s left) gem_exec_reloc (basic-write-gtt-active)
[699.572071] Subtest basic-write-gtt-active: SKIP (0.000s)
[699.655322] [123/133] (346s left) gem_exec_capture (capture-recoverable)
[699.711408] Starting subtest: capture-recoverable
[699.713237] Subtest capture-recoverable: SUCCESS (0.003s)
[699.825844] [124/133] (345s left) gem_ctx_param (non-root-set)
[699.880971] Starting subtest: non-root-set
[699.900349] Subtest non-root-set: SUCCESS (0.019s)
[699.985621] [125/133] (345s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[700.078271] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[700.081874] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[700.178824] [126/133] (345s left) kms_dsc (dsc-with-formats)
[700.273615] Starting subtest: dsc-with-formats
[700.306231] Subtest dsc-with-formats: SKIP (0.001s)
[700.358126] [127/133] (345s left) gem_eio (in-flight-contexts-immediate)
[700.588178] Starting subtest: in-flight-contexts-immediate
[712.486793] Subtest in-flight-contexts-immediate: SUCCESS (11.897s)
[712.606884] [128/133] (333s left) gem_exec_balancer (bonded-semaphore)
[712.663970] Starting subtest: bonded-semaphore
[712.668872] Subtest bonded-semaphore: SKIP (0.000s)
[712.983597] [129/133] (332s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[713.091271] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[713.095659] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[713.200686] [130/133] (332s left) syncobj_timeline (wait-delayed-signal)
[713.254164] Starting subtest: wait-delayed-signal
[713.356897] Subtest wait-delayed-signal: SUCCESS (0.103s)
[713.452335] [131/133] (332s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[713.565112] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[713.569352] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[713.673459] [132/133] (332s left) kms_chamelium_color (ctm-max)
[713.769593] Subtest ctm-max: SKIP (0.000s)
[713.813583] [133/133] (332s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[713.916644] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[713.921107] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[714.040894] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: gem_request_retire
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_prime
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_mmap_offset
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: i915_hangman
results: parsing output: 14/ for test: kms_color_pipeline
results: parsing output: 15/ for test: gem_exec_nop
results: parsing output: 16/ for test: prime_self_import
results: parsing output: 17/ for test: core_getclient
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: i915_suspend
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: gem_basic
results: parsing output: 25/ for test: kms_plane
results: parsing output: 26/ for test: kms_atomic_transition
results: parsing output: 27/ for test: kms_plane_cursor
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: api_intel_bb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_prop_blob
results: parsing output: 48/ for test: gem_pipe_control_store_loop
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_pm_dc
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gen3_render_tiledx_blits
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: syncobj_eventfd
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_atomic
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ppgtt
results: parsing output: 67/ for test: gem_exec_capture
results: parsing output: 68/ for test: kms_dp_linktrain_fallback
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_pipe_crc_basic
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_invalid_mode
results: parsing output: 75/ for test: gem_madvise
results: parsing output: 76/ for test: gem_exec_whisper
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_chamelium_edid
results: parsing output: 79/ for test: gem_bad_reloc
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: i915_drm_fdinfo
results: parsing output: 82/ for test: kms_selftest
results: parsing output: 83/ for test: kms_async_flips
results: parsing output: 84/ for test: gem_ctx_param
results: parsing output: 85/ for test: core_setmaster
results: parsing output: 86/ for test: prime_mmap
results: parsing output: 87/ for test: gen7_exec_parse
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_rotation_crc
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_chamelium_hpd
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: gem_spin_batch
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: gem_ctx_engines
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: gem_mmap_wc
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: kms_vblank
results: parsing output: 111/ for test: prime_busy
results: parsing output: 112/ for test: kms_lease
results: parsing output: 113/ for test: kms_cursor_edge_walk
results: parsing output: 114/ for test: i915_pm_rps
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_getfb
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: gem_exec_capture
results: parsing output: 123/ for test: gem_ctx_param
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_dsc
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_chamelium_color
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.