[60.857603] Initializing watchdogs
[60.857651]   /dev/watchdog0
[60.872213] [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]
[60.876703] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.879373] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.884473] [001/133] (960s left) kms_addfb_basic (invalid-set-prop)
[60.963825] Starting subtest: invalid-set-prop
[60.966046] Subtest invalid-set-prop: SUCCESS (0.000s)
[61.126761] [002/133] (960s left) kms_cursor_legacy (single-bo)
[61.241414] Starting subtest: single-bo
[61.243677] Starting dynamic subtest: pipe-A
[66.630035] Dynamic subtest pipe-A: SUCCESS (5.380s)
[66.638072] Starting dynamic subtest: pipe-B
[72.015721] Dynamic subtest pipe-B: SUCCESS (5.381s)
[72.024404] Starting dynamic subtest: pipe-C
[77.396850] Dynamic subtest pipe-C: SUCCESS (5.379s)
[77.404737] Starting dynamic subtest: pipe-D
[82.778654] Dynamic subtest pipe-D: SUCCESS (5.381s)
[82.785072] Starting dynamic subtest: all-pipes
[88.168366] Dynamic subtest all-pipes: SUCCESS (5.388s)
[88.170556] Subtest single-bo: SUCCESS (26.913s)
[88.310149] [003/133] (933s left) gem_exec_reloc (basic-concurrent0)
[88.375131] Subtest basic-concurrent0: SKIP (0.000s)
[88.439701] [004/133] (933s left) kms_invalid_mode (bad-hsync-end)
[88.537664] Starting subtest: bad-hsync-end
[88.539861] Starting dynamic subtest: pipe-A-eDP-1
[88.820378] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[88.830915] Starting dynamic subtest: pipe-B-eDP-1
[88.833140] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[88.839731] Starting dynamic subtest: pipe-C-eDP-1
[88.841897] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[88.848320] Starting dynamic subtest: pipe-D-eDP-1
[88.850202] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[88.852063] Subtest bad-hsync-end: SUCCESS (0.290s)
[89.650579] [005/133] (931s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[89.751319] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[93.898295] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.150s)
[95.067700] [006/133] (926s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[95.167645] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[95.172177] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[95.255278] [007/133] (926s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[95.352447] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[101.937290] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.587s)
[102.057959] [008/133] (919s left) kms_prop_blob (basic)
[102.119912] Starting subtest: basic
[102.122263] Subtest basic: SUCCESS (0.000s)
[102.237202] [009/133] (919s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[102.334627] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[102.336956] Starting dynamic subtest: pipe-A-default-mode
[103.459297] Dynamic subtest pipe-A-default-mode: SKIP (1.125s)
[103.463374] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.127s)
[103.625185] [010/133] (918s left) vgem_basic (dmabuf-fence)
[103.689887] Starting subtest: dmabuf-fence
[103.692262] Subtest dmabuf-fence: SUCCESS (0.001s)
[103.743680] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[103.746667] [011/133] (918s left) perf (sysctl-defaults)
[103.809995] Starting subtest: sysctl-defaults
[103.812052] Subtest sysctl-defaults: SUCCESS (0.000s)
[103.913216] [012/133] (917s left) gem_lmem_swapping (massive)
[103.954417] Subtest massive: SKIP (0.000s)
[104.000042] [013/133] (917s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[104.094992] Starting subtest: plane-all-modeset-transition-internal-panels
[104.097416] Starting dynamic subtest: pipe-A-eDP-1
[105.377317] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.281s)
[105.654658] Starting dynamic subtest: pipe-B-eDP-1
[106.700250] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.052s)
[106.966970] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.873s)
[107.805557] [014/133] (914s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[107.913606] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[107.915704] Starting dynamic subtest: pipe-A-eDP-1
[110.140509] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.228s)
[110.149055] Starting dynamic subtest: pipe-B-eDP-1
[112.609751] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.468s)
[112.621328] Starting dynamic subtest: pipe-C-eDP-1
[114.862657] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.251s)
[114.871065] Starting dynamic subtest: pipe-D-eDP-1
[117.012245] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.149s)
[117.014305] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (9.101s)
[118.172083] [015/133] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[118.268674] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[118.273222] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[118.367081] [016/133] (903s left) kms_flip (2x-flip-vs-panning-interruptible)
[118.461715] Starting subtest: 2x-flip-vs-panning-interruptible
[118.474339] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[118.559349] [017/133] (903s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[118.649572] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[118.653761] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[118.743566] [018/133] (903s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[118.839066] Starting subtest: y-tiled-16bpp-rotate-270
[118.843636] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[118.932170] [019/133] (903s left) gem_spin_batch (resubmit-new)
[118.992737] Starting subtest: resubmit-new
[118.995053] Starting dynamic subtest: rcs0
[119.001279] Dynamic subtest rcs0: SUCCESS (0.008s)
[119.010838] Starting dynamic subtest: bcs0
[119.013171] Dynamic subtest bcs0: SUCCESS (0.005s)
[119.022490] Starting dynamic subtest: vcs0
[119.024722] Dynamic subtest vcs0: SUCCESS (0.004s)
[119.033440] Starting dynamic subtest: vcs1
[119.035308] Dynamic subtest vcs1: SUCCESS (0.004s)
[119.042097] Starting dynamic subtest: vecs0
[119.043908] Dynamic subtest vecs0: SUCCESS (0.006s)
[119.050672] Starting dynamic subtest: ccs0
[119.052559] Dynamic subtest ccs0: SUCCESS (0.004s)
[119.054443] Subtest resubmit-new: SUCCESS (0.034s)
[120.955958] [020/133] (901s left) syncobj_eventfd (invalid-bad-flags)
[121.009729] Starting subtest: invalid-bad-flags
[121.012048] Subtest invalid-bad-flags: SUCCESS (0.000s)
[121.104058] [021/133] (901s left) gem_exec_fence (syncobj-invalid-wait)
[121.534229] Starting subtest: syncobj-invalid-wait
[121.536697] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[122.957962] [022/133] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[123.072621] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[123.077088] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[123.162244] [023/133] (899s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[123.268466] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[123.272981] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[123.377566] [024/133] (898s left) kms_addfb_basic (basic-x-tiled-legacy)
[123.447935] Starting subtest: basic-x-tiled-legacy
[123.452352] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[123.590708] [025/133] (898s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[123.646989] Starting subtest: single-wait-all-for-submit-available-submitted
[123.649317] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[123.748795] [026/133] (898s left) gem_ctx_param (invalid-param-set)
[123.816305] Starting subtest: invalid-param-set
[123.818565] Subtest invalid-param-set: SUCCESS (0.000s)
[123.890376] [027/133] (898s left) api_intel_bb (blit-reloc-purge-cache)
[123.949267] Starting subtest: blit-reloc-purge-cache
[123.952894] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[124.076684] [028/133] (898s left) kms_cursor_crc (cursor-sliding-128x42)
[124.294066] Starting subtest: cursor-sliding-128x42
[124.343082] Subtest cursor-sliding-128x42: SKIP (0.044s)
[124.553209] [029/133] (897s left) kms_busy (extended-modeset-hang-newfb)
[124.658345] Starting subtest: extended-modeset-hang-newfb
[124.660245] Starting dynamic subtest: pipe-A
[158.829877] Dynamic subtest pipe-A: SUCCESS (34.166s)
[158.838748] Starting dynamic subtest: pipe-D
[181.801828] Dynamic subtest pipe-D: SUCCESS (22.970s)
[181.804306] Subtest extended-modeset-hang-newfb: SUCCESS (57.141s)
[182.606893] [030/133] (839s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[182.716830] Starting subtest: yf-tiled-16bpp-rotate-270
[182.721128] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[182.798694] [031/133] (839s left) gem_exec_balancer (hog)
[182.867971] Starting subtest: hog
[182.872292] Subtest hog: SKIP (0.000s)
[183.179997] [032/133] (839s left) gem_ctx_param (invalid-get-engines)
[183.249476] Starting subtest: invalid-get-engines
[183.252019] Subtest invalid-get-engines: SUCCESS (0.001s)
[183.365387] [033/133] (839s left) kms_cursor_edge_walk (128x128-top-edge)
[183.458106] Starting subtest: 128x128-top-edge
[183.460401] Starting dynamic subtest: pipe-A-eDP-1
[186.886169] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s)
[186.894580] Starting dynamic subtest: pipe-D-eDP-1
[190.005324] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[190.007678] Subtest 128x128-top-edge: SUCCESS (6.547s)
[190.809244] [034/133] (831s left) syncobj_timeline (reset-unsignaled)
[190.868898] Starting subtest: reset-unsignaled
[190.871317] Subtest reset-unsignaled: SUCCESS (0.000s)
[190.973343] [035/133] (831s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[191.065150] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[191.067374] Starting dynamic subtest: pipe-A-eDP-1
[191.153871] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[191.163986] Starting dynamic subtest: pipe-B-eDP-1
[192.284884] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[192.289174] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.223s)
[193.484332] [036/133] (829s left) gem_exec_await (wide-all)
[193.677185] Starting subtest: wide-all
[216.822420] Subtest wide-all: SUCCESS (23.143s)
[217.017504] [037/133] (805s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[217.149325] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[217.153281] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[217.217137] [038/133] (805s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[217.313096] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[217.315392] Starting dynamic subtest: pipe-A-eDP-1
[217.335915] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[217.346196] Starting dynamic subtest: pipe-B-eDP-1
[217.365606] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[217.373442] Starting dynamic subtest: pipe-C-eDP-1
[217.392896] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[217.400670] Starting dynamic subtest: pipe-D-eDP-1
[217.419699] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[217.421877] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[219.534047] [039/133] (803s left) gem_mmap_gtt (hang-user)
[219.601124] Subtest hang-user: SKIP (0.000s)
[219.672620] [040/133] (803s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[219.754888] Starting subtest: read-crc-frame-sequence
[219.757222] Starting dynamic subtest: pipe-A-eDP-1
[220.475665] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[220.484944] Starting dynamic subtest: pipe-B-eDP-1
[221.819480] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[221.830605] Starting dynamic subtest: pipe-C-eDP-1
[223.129094] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.309s)
[223.138420] Starting dynamic subtest: pipe-D-eDP-1
[224.463580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[224.465928] Subtest read-crc-frame-sequence: SUCCESS (4.710s)
[225.277758] [041/133] (797s left) gem_userptr_blits (usage-restrictions)
[225.343914] Starting subtest: usage-restrictions
[225.346314] Subtest usage-restrictions: SUCCESS (0.000s)
[225.458756] [042/133] (797s left) gem_lmem_swapping (parallel-random-verify)
[225.509221] Subtest parallel-random-verify: SKIP (0.000s)
[225.556594] [043/133] (797s left) kms_lease (lease-invalid-crtc)
[225.651555] Starting subtest: lease-invalid-crtc
[225.653676] Starting dynamic subtest: pipe-A-eDP-1
[225.655576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[225.664496] Starting dynamic subtest: pipe-B-eDP-1
[225.666569] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[225.674911] Starting dynamic subtest: pipe-C-eDP-1
[225.676726] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[225.684692] Starting dynamic subtest: pipe-D-eDP-1
[225.686827] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[225.688975] Subtest lease-invalid-crtc: SUCCESS (0.007s)
[225.732134] [044/133] (797s left) gem_exec_create (basic)
[225.814347] Starting subtest: basic
[225.816733] Starting dynamic subtest: smem
[227.924254] Dynamic subtest smem: SUCCESS (2.112s)
[227.926842] Subtest basic: SUCCESS (2.114s)
[228.111405] [045/133] (795s left) kms_flip (basic-flip-vs-modeset)
[228.218960] Starting subtest: basic-flip-vs-modeset
[228.220861] Starting dynamic subtest: A-eDP1
[230.785302] Dynamic subtest A-eDP1: SUCCESS (2.565s)
[230.794236] Starting dynamic subtest: B-eDP1
[232.946894] Dynamic subtest B-eDP1: SUCCESS (2.160s)
[232.956221] Starting dynamic subtest: C-eDP1
[235.112268] Dynamic subtest C-eDP1: SUCCESS (2.165s)
[235.120512] Starting dynamic subtest: D-eDP1
[237.272513] Dynamic subtest D-eDP1: SUCCESS (2.161s)
[237.275136] Subtest basic-flip-vs-modeset: SUCCESS (9.058s)
[238.069040] [046/133] (785s left) kms_rotation_crc (sprite-rotation-270)
[238.167976] Starting subtest: sprite-rotation-270
[238.172575] Subtest sprite-rotation-270: SKIP (0.001s)
[238.242341] [047/133] (785s left) kms_async_flips (test-cursor-atomic)
[238.349368] Starting subtest: test-cursor-atomic
[238.724577] Starting dynamic subtest: pipe-A-eDP-1
[239.461456] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[239.852799] Starting dynamic subtest: pipe-B-eDP-1
[240.593141] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.748s)
[240.969747] Starting dynamic subtest: pipe-C-eDP-1
[241.723440] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s)
[242.089293] Starting dynamic subtest: pipe-D-eDP-1
[242.856257] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s)
[242.858653] Subtest test-cursor-atomic: SUCCESS (4.510s)
[244.033566] [048/133] (779s left) kms_vblank (wait-forked-hang)
[244.123217] Starting subtest: wait-forked-hang
[244.125153] Starting dynamic subtest: pipe-A-eDP-1
[270.683536] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.560s)
[270.697863] Starting dynamic subtest: pipe-D-eDP-1
[285.664769] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.977s)
[285.667218] Subtest wait-forked-hang: SUCCESS (41.542s)
[286.500476] [049/133] (736s left) kms_big_fb (linear-32bpp-rotate-270)
[286.606355] Starting subtest: linear-32bpp-rotate-270
[286.628248] Subtest linear-32bpp-rotate-270: SKIP (0.021s)
[286.728823] [050/133] (736s left) gem_mmap (basic)
[286.785139] Subtest basic: SKIP (0.000s)
[286.841504] [051/133] (736s left) gem_ctx_persistence (file)
[286.902396] Starting subtest: file
[287.000928] Subtest file: SUCCESS (0.099s)
[287.110803] [052/133] (736s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[287.204061] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[287.206324] Starting dynamic subtest: pipe-A-eDP-1
[287.228984] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[287.238736] Starting dynamic subtest: pipe-B-eDP-1
[287.259873] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[287.268042] Starting dynamic subtest: pipe-C-eDP-1
[287.289270] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[287.296758] Starting dynamic subtest: pipe-D-eDP-1
[287.318644] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[287.322850] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[289.455119] [053/133] (734s left) gem_tiled_pread_pwrite
[289.587028] [054/133] (733s left) kms_chamelium_color (ctm-red-to-blue)
[289.675585] Subtest ctm-red-to-blue: SKIP (0.000s)
[289.719315] [055/133] (733s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[289.820267] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[289.824587] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[289.923022] [056/133] (733s left) i915_pm_rpm (system-suspend)
[292.056759] Starting subtest: system-suspend
[310.373315] Subtest system-suspend: SUCCESS (3.195s)
[310.744853] [057/133] (712s left) i915_query (query-garbage)
[310.814740] Starting subtest: query-garbage
[310.816683] Subtest query-garbage: SUCCESS (0.000s)
[310.917868] [058/133] (712s left) i915_query (engine-info-invalid)
[310.980187] Starting subtest: engine-info-invalid
[310.982226] Subtest engine-info-invalid: SUCCESS (0.000s)
[311.074190] [059/133] (712s left) syncobj_wait (invalid-signal-illegal-handle)
[311.127020] Starting subtest: invalid-signal-illegal-handle
[311.129276] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[311.221895] [060/133] (712s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[311.308265] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[311.310513] Starting dynamic subtest: pipe-A-eDP-1
[312.071293] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s)
[312.080537] Starting dynamic subtest: pipe-B-eDP-1
[313.896014] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.806s)
[313.908251] Starting dynamic subtest: pipe-C-eDP-1
[315.740574] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.828s)
[315.755292] Starting dynamic subtest: pipe-D-eDP-1
[317.581083] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.829s)
[317.583327] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.215s)
[318.715044] [061/133] (705s left) api_intel_bb (reset-bb)
[318.779561] Starting subtest: reset-bb
[318.781797] Subtest reset-bb: SUCCESS (0.004s)
[318.914842] [062/133] (704s left) kms_psr (fbc-pr-primary-mmap-cpu)
[319.019473] Starting subtest: fbc-pr-primary-mmap-cpu
[319.023810] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[319.092914] [063/133] (704s left) kms_psr (psr2-cursor-mmap-gtt)
[319.190568] Starting subtest: psr2-cursor-mmap-gtt
[319.192863] Starting dynamic subtest: eDP-1
[320.910106] Dynamic subtest eDP-1: SUCCESS (1.711s)
[320.912479] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.712s)
[321.701332] [064/133] (702s left) gem_exec_schedule (reorder-wide)
[321.884048] Subtest reorder-wide: SKIP (0.000s)
[322.065490] [065/133] (701s left) prime_busy (after)
[322.127945] Starting subtest: after
[322.133260] Starting dynamic subtest: rcs0
[322.157282] Dynamic subtest rcs0: SUCCESS (0.026s)
[322.167768] Starting dynamic subtest: bcs0
[322.198608] Dynamic subtest bcs0: SUCCESS (0.040s)
[322.208236] Starting dynamic subtest: vcs0
[322.239275] Dynamic subtest vcs0: SUCCESS (0.040s)
[322.249018] Starting dynamic subtest: vcs1
[322.280392] Dynamic subtest vcs1: SUCCESS (0.040s)
[322.289913] Starting dynamic subtest: vecs0
[322.321035] Dynamic subtest vecs0: SUCCESS (0.040s)
[322.330189] Starting dynamic subtest: ccs0
[322.361808] Dynamic subtest ccs0: SUCCESS (0.040s)
[322.471483] Subtest after: SUCCESS (0.340s)
[322.561508] [066/133] (701s left) i915_module_load (reload)
[322.613483] Starting subtest: reload
[327.560773] Subtest reload: SUCCESS (4.941s)
[327.609066] [067/133] (696s left) syncobj_wait (multi-wait-for-submit-signaled)
[328.975924] Starting subtest: multi-wait-for-submit-signaled
[328.978282] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[329.085448] [068/133] (695s left) kms_plane (pixel-format-y-tiled-modifier)
[329.182342] Starting subtest: pixel-format-y-tiled-modifier
[329.186551] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[329.257613] [069/133] (694s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[329.645298] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[330.419421] [070/133] (693s left) kms_content_protection (atomic-dpms-hdcp14)
[330.580509] Starting subtest: atomic-dpms-hdcp14
[330.585222] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[330.720803] [071/133] (693s left) gem_create (hog-create)
[330.780029] Starting subtest: hog-create
[330.782462] Starting dynamic subtest: smem0
[364.011685] Dynamic subtest smem0: SUCCESS (33.216s)
[364.014388] Subtest hog-create: SUCCESS (33.218s)
[364.221637] [072/133] (660s left) perf (non-system-wide-paranoid)
[364.375608] Starting subtest: non-system-wide-paranoid
[364.407155] Subtest non-system-wide-paranoid: SUCCESS (0.032s)
[364.460004] [073/133] (659s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[364.566376] Starting subtest: x-tiled-16bpp-rotate-270
[364.586335] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[364.692663] [074/133] (659s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[364.792241] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[364.794536] Starting dynamic subtest: A-eDP1
[368.377892] Dynamic subtest A-eDP1: SUCCESS (3.583s)
[368.387333] Starting dynamic subtest: B-eDP1
[371.568774] Dynamic subtest B-eDP1: SUCCESS (3.188s)
[371.578479] Starting dynamic subtest: C-eDP1
[374.697650] Dynamic subtest C-eDP1: SUCCESS (3.125s)
[374.706532] Starting dynamic subtest: D-eDP1
[377.798155] Dynamic subtest D-eDP1: SUCCESS (3.098s)
[377.800393] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.001s)
[378.601055] [075/133] (645s left) kms_flip (2x-flip-vs-wf_vblank)
[378.704516] Starting subtest: 2x-flip-vs-wf_vblank
[378.713864] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[378.790257] [076/133] (645s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[378.885344] Starting subtest: pipe-fbc-rte
[378.892063] Starting dynamic subtest: pipe-B-eDP-1
[384.378247] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.493s)
[384.386015] Subtest pipe-fbc-rte: SUCCESS (5.496s)
[386.649224] [077/133] (637s left) gem_ctx_param (root-set)
[386.701507] Starting subtest: root-set
[386.703957] Subtest root-set: SUCCESS (0.001s)
[386.808714] [078/133] (637s left) kms_psr (fbc-psr-basic)
[386.905720] Starting subtest: fbc-psr-basic
[386.907907] Starting dynamic subtest: eDP-1
[386.912570] Dynamic subtest eDP-1: SKIP (0.000s)
[386.916774] Subtest fbc-psr-basic: SKIP (0.001s)
[386.977146] [079/133] (637s left) kms_psr (pr-cursor-plane-move)
[387.077875] Starting subtest: pr-cursor-plane-move
[387.082313] Subtest pr-cursor-plane-move: SKIP (0.000s)
[387.165935] [080/133] (637s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[387.273847] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[387.278218] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[387.361652] [081/133] (637s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[387.461692] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[394.290674] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.828s)
[394.420178] [082/133] (630s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[394.484514] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[394.542855] [083/133] (630s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[394.646827] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[398.217703] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.572s)
[399.374034] [084/133] (625s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[399.480254] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[399.484949] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[399.580920] [085/133] (625s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[399.638142] Starting subtest: single-wait-for-submit-unsubmitted
[399.738402] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[399.813032] [086/133] (625s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[399.936904] Starting subtest: cursorB-vs-flipB-toggle
[399.941253] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[400.085008] [087/133] (624s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[400.145659] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[400.251708] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[400.327652] [088/133] (624s left) gem_mmap_wc (bad-object)
[400.402007] Subtest bad-object: SKIP (0.000s)
[400.461046] [089/133] (624s left) kms_flip (modeset-vs-vblank-race-interruptible)
[400.553214] Starting subtest: modeset-vs-vblank-race-interruptible
[400.555483] Starting dynamic subtest: A-eDP1
[405.265245] Dynamic subtest A-eDP1: SUCCESS (4.708s)
[405.277504] Starting dynamic subtest: B-eDP1
[409.912519] Dynamic subtest B-eDP1: SUCCESS (4.647s)
[409.924570] Starting dynamic subtest: C-eDP1
[414.495696] Dynamic subtest C-eDP1: SUCCESS (4.583s)
[414.507993] Starting dynamic subtest: D-eDP1
[419.123192] Dynamic subtest D-eDP1: SUCCESS (4.626s)
[419.128369] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.578s)
[420.289333] [090/133] (604s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[420.421922] Starting subtest: basic-flip-before-cursor-varying-size
[421.352209] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.928s)
[422.249094] [091/133] (602s left) gem_exec_store (basic)
[422.311403] Starting subtest: basic
[422.409233] Subtest basic: SUCCESS (0.099s)
[422.596845] [092/133] (602s left) gem_exec_params (secure-non-root)
[422.661617] Starting subtest: secure-non-root
[422.665570] Subtest secure-non-root: SKIP (0.000s)
[422.760395] [093/133] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[422.872328] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[422.876784] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[422.975175] [094/133] (602s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[423.075071] Starting subtest: 4-tiled-32bpp-rotate-90
[423.095746] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[423.210293] [095/133] (602s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[423.317703] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[423.319763] Starting dynamic subtest: pipe-A-eDP-1
[423.339464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[423.349239] Starting dynamic subtest: pipe-B-eDP-1
[423.368759] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[423.377755] Starting dynamic subtest: pipe-C-eDP-1
[423.396693] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[423.405577] Starting dynamic subtest: pipe-D-eDP-1
[423.424790] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[423.426914] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.088s)
[425.698070] [096/133] (599s left) gem_ctx_shared (single-timeline)
[425.760532] Starting subtest: single-timeline
[425.781070] Subtest single-timeline: SUCCESS (0.015s)
[425.997726] [097/133] (599s left) kms_feature_discovery (display-4x)
[426.084645] Starting subtest: display-4x
[426.088630] Subtest display-4x: SKIP (0.000s)
[426.157306] [098/133] (599s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[426.282505] Starting subtest: protected-encrypted-src-copy-not-readible
[426.395495] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.114s)
[426.510118] [099/133] (598s left) kms_selftest (drm_format_helper)
[426.554714] Starting subtest: drm_format_helper
[426.603829] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[426.705030] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.099s)
[426.714917] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[426.794297] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.090s)
[426.804849] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[426.896100] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.102s)
[426.906396] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[427.002511] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.105s)
[427.012502] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[427.113710] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.108s)
[427.123528] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[427.199931] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.085s)
[427.208247] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[427.306137] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.107s)
[427.314850] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[427.403745] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.094s)
[427.412487] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[427.499012] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.096s)
[427.507178] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[427.600340] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.100s)
[427.609352] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[427.698726] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.098s)
[427.706961] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[427.800321] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.102s)
[427.809533] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[427.897982] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.096s)
[427.906343] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[428.012524] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.112s)
[428.020849] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[428.129932] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.118s)
[428.140545] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[428.233818] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.101s)
[428.242263] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[428.323655] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.088s)
[428.325482] Subtest drm_format_helper: SUCCESS (1.769s)
[428.468202] [100/133] (597s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[428.561408] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[435.961393] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.402s)
[436.103119] [101/133] (589s left) syncobj_timeline (wait-any-snapshot)
[436.176385] Starting subtest: wait-any-snapshot
[436.256620] Subtest wait-any-snapshot: SUCCESS (0.082s)
[436.342565] [102/133] (589s left) perf (non-sampling-read-error)
[436.447423] Starting subtest: non-sampling-read-error
[436.458993] Subtest non-sampling-read-error: SUCCESS (0.008s)
[436.504671] [103/133] (589s left) gem_mmap_gtt (basic)
[436.569694] Subtest basic: SKIP (0.000s)
[436.637036] [104/133] (589s left) kms_cursor_crc (cursor-onscreen-256x256)
[436.874296] Starting subtest: cursor-onscreen-256x256
[436.879122] Starting dynamic subtest: pipe-A-eDP-1
[438.992148] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.115s)
[439.026900] Starting dynamic subtest: pipe-D-eDP-1
[441.804957] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.786s)
[441.807385] Subtest cursor-onscreen-256x256: SUCCESS (4.930s)
[442.691633] [105/133] (583s left) i915_drm_fdinfo (memory-info-resident)
[442.743388] Starting subtest: memory-info-resident
[442.745868] Starting dynamic subtest: smem0
[445.465933] Dynamic subtest smem0: SUCCESS (2.724s)
[445.468492] Subtest memory-info-resident: SUCCESS (2.725s)
[445.541988] [106/133] (580s left) kms_setmode (clone-exclusive-crtc)
[445.601225] Starting subtest: clone-exclusive-crtc
[445.606881] Subtest clone-exclusive-crtc: SKIP (0.000s)
[445.711460] [107/133] (580s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[445.831180] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[445.834923] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[445.976141] [108/133] (579s left) kms_psr (fbc-psr2-sprite-blt)
[446.071834] Starting subtest: fbc-psr2-sprite-blt
[446.073765] Starting dynamic subtest: eDP-1
[446.077285] Dynamic subtest eDP-1: SKIP (0.000s)
[446.081790] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[446.149487] [109/133] (579s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[446.237895] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[446.239868] Starting dynamic subtest: pipe-A-default-mode
[447.364169] Dynamic subtest pipe-A-default-mode: SKIP (1.123s)
[447.368290] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.124s)
[447.508760] [110/133] (578s left) perf_pmu (busy-idle)
[447.553334] Starting subtest: busy-idle
[447.555496] Starting dynamic subtest: rcs0
[448.241487] Dynamic subtest rcs0: SUCCESS (0.688s)
[448.254175] Starting dynamic subtest: bcs0
[448.905333] Dynamic subtest bcs0: SUCCESS (0.661s)
[448.918136] Starting dynamic subtest: vcs0
[450.025825] Dynamic subtest vcs0: SUCCESS (1.118s)
[450.038822] Starting dynamic subtest: vcs1
[452.008916] Dynamic subtest vcs1: SUCCESS (1.979s)
[452.021733] Starting dynamic subtest: vecs0
[454.058009] Dynamic subtest vecs0: SUCCESS (2.046s)
[454.070515] Starting dynamic subtest: ccs0
[454.723220] Dynamic subtest ccs0: SUCCESS (0.663s)
[454.726295] Subtest busy-idle: SUCCESS (7.170s)
[454.827691] [111/133] (571s left) kms_pm_dc (dc6-psr)
[455.924298] Starting subtest: dc6-psr
[458.911283] Subtest dc6-psr: SUCCESS (2.987s)
[459.765213] [112/133] (566s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[459.826423] Starting subtest: multi-wait-for-submit-submitted-signaled
[459.828764] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[459.927992] [113/133] (566s left) kms_plane_cursor (overlay)
[460.025476] Starting subtest: overlay
[460.029983] Starting dynamic subtest: pipe-A-eDP-1-size-64
[462.624428] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.598s)
[462.685388] Starting dynamic subtest: pipe-A-eDP-1-size-128
[465.247911] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s)
[465.306954] Starting dynamic subtest: pipe-A-eDP-1-size-256
[467.827257] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.527s)
[468.192877] Starting dynamic subtest: pipe-B-eDP-1-size-64
[471.426958] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.244s)
[471.488305] Starting dynamic subtest: pipe-B-eDP-1-size-128
[474.028209] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[474.089460] Starting dynamic subtest: pipe-B-eDP-1-size-256
[476.663582] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[477.034404] Starting dynamic subtest: pipe-C-eDP-1-size-64
[479.982924] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.960s)
[480.021394] Starting dynamic subtest: pipe-C-eDP-1-size-128
[482.206226] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s)
[482.244246] Starting dynamic subtest: pipe-C-eDP-1-size-256
[484.406319] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.170s)
[484.737800] Starting dynamic subtest: pipe-D-eDP-1-size-64
[487.619787] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.895s)
[487.658167] Starting dynamic subtest: pipe-D-eDP-1-size-128
[489.853900] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s)
[489.891161] Starting dynamic subtest: pipe-D-eDP-1-size-256
[492.087552] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.203s)
[492.406972] Subtest overlay: SUCCESS (32.374s)
[493.212023] [114/133] (532s left) kms_flip (plain-flip-ts-check)
[493.299784] Starting subtest: plain-flip-ts-check
[493.302156] Starting dynamic subtest: A-eDP1
[502.196191] Dynamic subtest A-eDP1: SUCCESS (8.893s)
[502.208838] Starting dynamic subtest: B-eDP1
[511.030067] Dynamic subtest B-eDP1: SUCCESS (8.828s)
[511.045418] Starting dynamic subtest: C-eDP1
[519.853866] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[519.865337] Starting dynamic subtest: D-eDP1
[528.681211] Dynamic subtest D-eDP1: SUCCESS (8.823s)
[528.686092] Subtest plain-flip-ts-check: SUCCESS (35.376s)
[529.864080] [115/133] (496s left) gen7_exec_parse (chained-batch)
[529.922184] Subtest chained-batch: SKIP (0.000s)
[530.000387] [116/133] (496s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[530.095684] Starting subtest: plane-ctm3x4-lut1d
[530.241480] Starting dynamic subtest: pipe-A-plane-0
[530.407529] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[530.417571] Starting dynamic subtest: pipe-A-plane-1
[530.563949] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[530.574625] Starting dynamic subtest: pipe-A-plane-2
[530.732757] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[531.948250] Starting dynamic subtest: pipe-B-plane-0
[532.105964] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[532.116720] Starting dynamic subtest: pipe-B-plane-1
[532.273006] Dynamic subtest pipe-B-plane-1: SUCCESS (0.165s)
[532.283064] Starting dynamic subtest: pipe-B-plane-2
[532.462825] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[533.684740] Starting dynamic subtest: pipe-C-plane-0
[533.810336] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[533.819930] Starting dynamic subtest: pipe-C-plane-1
[533.956118] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[533.967515] Starting dynamic subtest: pipe-C-plane-2
[534.110167] Dynamic subtest pipe-C-plane-2: SUCCESS (0.153s)
[535.318601] Starting dynamic subtest: pipe-D-plane-0
[535.444465] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[535.461067] Starting dynamic subtest: pipe-D-plane-1
[535.599671] Dynamic subtest pipe-D-plane-1: SUCCESS (0.153s)
[535.610077] Starting dynamic subtest: pipe-D-plane-2
[535.766126] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[536.054114] Subtest plane-ctm3x4-lut1d: SUCCESS (5.960s)
[536.905931] [117/133] (489s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[537.014257] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[537.016477] Starting dynamic subtest: pipe-A
[537.037518] Dynamic subtest pipe-A: SKIP (0.019s)
[537.048146] Starting dynamic subtest: pipe-B
[537.068080] Dynamic subtest pipe-B: SKIP (0.031s)
[537.077800] Starting dynamic subtest: pipe-C
[537.099633] Dynamic subtest pipe-C: SKIP (0.031s)
[537.109401] Starting dynamic subtest: pipe-D
[537.132507] Dynamic subtest pipe-D: SKIP (0.031s)
[537.136512] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.114s)
[537.233649] [118/133] (489s left) syncobj_timeline (invalid-wait-bad-flags)
[537.283722] Starting subtest: invalid-wait-bad-flags
[537.285925] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[537.387593] [119/133] (488s left) gem_basic (multigpu-create-close)
[537.434186] Starting subtest: multigpu-create-close
[537.438085] Subtest multigpu-create-close: SKIP (0.000s)
[537.540734] [120/133] (488s left) gem_exec_schedule (preempt-queue-chain)
[537.604751] Subtest preempt-queue-chain: SKIP (0.000s)
[537.897000] [121/133] (488s left) gem_exec_balancer (parallel-out-fence)
[538.165006] Starting subtest: parallel-out-fence
[539.408584] Subtest parallel-out-fence: SUCCESS (1.244s)
[539.518063] [122/133] (486s left) kms_vrr (flip-suspend)
[539.621578] Starting subtest: flip-suspend
[539.628257] Subtest flip-suspend: SKIP (0.000s)
[539.694041] [123/133] (486s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[539.791327] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[544.046887] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.261s)
[545.199192] [124/133] (481s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[545.310612] Starting subtest: pr-overlay-plane-update-continuous-sf
[545.314692] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[545.386215] [125/133] (481s left) gem_vm_create (invalid-create)
[545.450527] Starting subtest: invalid-create
[545.452755] Subtest invalid-create: SUCCESS (0.002s)
[545.558846] [126/133] (481s left) syncobj_wait (multi-wait-submitted)
[545.611779] Starting subtest: multi-wait-submitted
[545.716511] Subtest multi-wait-submitted: SUCCESS (0.104s)
[545.793160] [127/133] (480s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[545.889587] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[545.893832] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[545.991896] [128/133] (480s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[546.091753] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[553.194566] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.107s)
[553.300673] [129/133] (473s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[553.394794] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[560.980678] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.591s)
[561.127467] [130/133] (465s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[561.219206] Starting subtest: primary-4-tiled-reflect-x-0
[568.129132] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.912s)
[569.316844] [131/133] (457s left) gem_userptr_blits (relocations)
[569.388988] Starting subtest: relocations
[569.393589] Subtest relocations: SKIP (0.001s)
[569.520135] [132/133] (457s left) gem_ringfill (engines-basic)
[575.020220] Starting subtest: engines-basic
[575.022894] Starting dynamic subtest: rcs0
[575.078554] Dynamic subtest rcs0: SUCCESS (0.058s)
[575.089772] Starting dynamic subtest: bcs0
[575.124339] Dynamic subtest bcs0: SUCCESS (0.044s)
[575.138628] Starting dynamic subtest: vcs0
[575.168646] Dynamic subtest vcs0: SUCCESS (0.043s)
[575.180432] Starting dynamic subtest: vcs1
[575.211513] Dynamic subtest vcs1: SUCCESS (0.041s)
[575.222873] Starting dynamic subtest: vecs0
[575.256475] Dynamic subtest vecs0: SUCCESS (0.043s)
[575.267698] Starting dynamic subtest: ccs0
[575.301188] Dynamic subtest ccs0: SUCCESS (0.043s)
[575.303632] Subtest engines-basic: SUCCESS (0.283s)
[575.380920] [133/133] (451s left) dmabuf_sync_file (import-multiple-read-only)
[575.423930] Starting subtest: import-multiple-read-only
[575.425953] Subtest import-multiple-read-only: SUCCESS (0.003s)
[575.476518] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_invalid_mode
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_prop_blob
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: vgem_basic
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: kms_atomic_transition
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_spin_batch
results: parsing output: 19/ for test: syncobj_eventfd
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_ctx_param
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_busy
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_exec_balancer
results: parsing output: 31/ for test: gem_ctx_param
results: parsing output: 32/ for test: kms_cursor_edge_walk
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: gem_exec_await
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: kms_pipe_crc_basic
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: kms_lease
results: parsing output: 43/ for test: gem_exec_create
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_rotation_crc
results: parsing output: 46/ for test: kms_async_flips
results: parsing output: 47/ for test: kms_vblank
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: gem_mmap
results: parsing output: 50/ for test: gem_ctx_persistence
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: gem_tiled_pread_pwrite
results: parsing output: 53/ for test: kms_chamelium_color
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: i915_pm_rpm
results: parsing output: 56/ for test: i915_query
results: parsing output: 57/ for test: i915_query
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: api_intel_bb
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: prime_busy
results: parsing output: 65/ for test: i915_module_load
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: kms_content_protection
results: parsing output: 70/ for test: gem_create
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_ctx_param
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_pipe_b_c_ivb
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: gem_mmap_wc
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: gem_exec_store
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: gem_ctx_shared
results: parsing output: 96/ for test: kms_feature_discovery
results: parsing output: 97/ for test: gem_pxp
results: parsing output: 98/ for test: kms_selftest
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: perf
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: kms_setmode
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: kms_pm_dc
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: kms_plane_cursor
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: gen7_exec_parse
results: parsing output: 115/ for test: kms_color_pipeline
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: gem_basic
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: kms_vrr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: gem_vm_create
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_rotation_crc
results: parsing output: 130/ for test: gem_userptr_blits
results: parsing output: 131/ for test: gem_ringfill
results: parsing output: 132/ for test: dmabuf_sync_file
Done.