[62.564561] Initializing watchdogs
[62.564604]   /dev/watchdog0
[62.578352] [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]
[62.582498] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.584681] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.588195] [001/131] (960s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[62.722101] Starting subtest: 4-tiled-32bpp-rotate-270
[62.754587] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.032s)
[62.900316] [002/131] (960s left) kms_rotation_crc (multiplane-rotation)
[63.005938] Starting subtest: multiplane-rotation
[80.478363] Subtest multiplane-rotation: SUCCESS (17.437s)
[80.638757] [003/131] (942s left) perf (invalid-oa-metric-set-id)
[80.782903] Starting subtest: invalid-oa-metric-set-id
[80.794059] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[80.831454] [004/131] (942s left) syncobj_wait (wait-any-snapshot)
[80.889511] Starting subtest: wait-any-snapshot
[80.970615] Subtest wait-any-snapshot: SUCCESS (0.081s)
[81.062312] [005/131] (942s left) kms_psr (fbc-psr2-primary-blt)
[81.160169] Starting subtest: fbc-psr2-primary-blt
[81.162143] Starting dynamic subtest: eDP-1
[81.165923] Dynamic subtest eDP-1: SKIP (0.000s)
[81.169817] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[81.254908] [006/131] (942s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[86.189652] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[86.192043] Starting dynamic subtest: pipe-A-eDP-1
[98.236819] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.041s)
[98.245899] Starting dynamic subtest: pipe-B-eDP-1
[110.265553] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.022s)
[110.267798] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.067s)
[111.142302] [007/131] (912s left) i915_pm_rc6_residency (media-rc6-accuracy)
[111.206952] Starting subtest: media-rc6-accuracy
[111.211211] Subtest media-rc6-accuracy: SKIP (0.000s)
[111.329439] [008/131] (912s left) core_getversion (basic)
[111.364898] Starting subtest: basic
[111.369499] Subtest basic: SUCCESS (0.000s)
[111.445105] [009/131] (911s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[111.550516] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[111.554766] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[111.657500] [010/131] (911s left) kms_debugfs (display-off-read-all)
[111.761943] Starting subtest: display-off-read-all
[112.052434] Subtest display-off-read-all: SUCCESS (0.292s)
[112.861508] [011/131] (910s left) syncobj_timeline (host-signal-points)
[112.917834] Starting subtest: host-signal-points
[112.922403] Subtest host-signal-points: SUCCESS (0.004s)
[113.044479] [012/131] (910s left) gem_exec_store (basic)
[113.116958] Starting subtest: basic
[113.226543] Subtest basic: SUCCESS (0.109s)
[113.432831] [013/131] (910s left) gem_exec_flush (basic-wb-rw-default)
[113.501646] Starting subtest: basic-wb-rw-default
[118.992319] Subtest basic-wb-rw-default: SUCCESS (5.448s)
[119.158467] [014/131] (904s left) vgem_basic (setversion)
[119.231716] Starting subtest: setversion
[119.235741] Subtest setversion: SUCCESS (0.000s)
[119.306625] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[119.310137] [015/131] (904s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[119.357930] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[119.466973] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.108s)
[119.567142] [016/131] (904s left) kms_legacy_colorkey (basic)
[119.647911] Starting subtest: basic
[119.649849] Starting dynamic subtest: pipe-A
[119.690909] Dynamic subtest pipe-A: SUCCESS (0.045s)
[119.701131] Starting dynamic subtest: pipe-B
[119.703306] Dynamic subtest pipe-B: SUCCESS (0.001s)
[119.709655] Starting dynamic subtest: pipe-C
[119.711635] Dynamic subtest pipe-C: SUCCESS (0.000s)
[119.718758] Starting dynamic subtest: pipe-D
[119.720950] Dynamic subtest pipe-D: SUCCESS (0.000s)
[119.723101] Subtest basic: SUCCESS (0.049s)
[119.779798] [017/131] (903s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[119.866468] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[123.785351] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.921s)
[124.959176] [018/131] (898s left) kms_rmfb (close-fd)
[125.062192] Starting subtest: close-fd
[125.064178] Starting dynamic subtest: pipe-A-eDP-1
[125.169293] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[125.178201] Starting dynamic subtest: pipe-B-eDP-1
[126.389278] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.219s)
[126.397790] Starting dynamic subtest: pipe-C-eDP-1
[127.520937] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.131s)
[127.529041] Starting dynamic subtest: pipe-D-eDP-1
[128.659191] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[128.661558] Subtest close-fd: SUCCESS (3.598s)
[129.888417] [019/131] (893s left) kms_atomic_interruptible (legacy-dpms)
[129.994079] Starting subtest: legacy-dpms
[129.996452] Starting dynamic subtest: pipe-A-eDP-1
[137.388564] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.395s)
[137.390881] Subtest legacy-dpms: SUCCESS (7.396s)
[138.240657] [020/131] (885s left) gem_ctx_persistence (legacy-engines-hostile)
[138.309104] Starting subtest: legacy-engines-hostile
[138.311061] Starting dynamic subtest: render
[138.479062] Dynamic subtest render: SUCCESS (0.172s)
[138.489304] Starting dynamic subtest: bsd1
[138.595994] Dynamic subtest bsd1: SUCCESS (0.114s)
[138.605680] Starting dynamic subtest: bsd2
[138.721697] Dynamic subtest bsd2: SUCCESS (0.124s)
[138.731200] Starting dynamic subtest: blt
[138.836827] Dynamic subtest blt: SUCCESS (0.113s)
[138.846259] Starting dynamic subtest: vebox
[138.947326] Dynamic subtest vebox: SUCCESS (0.107s)
[138.950178] Subtest legacy-engines-hostile: SUCCESS (0.641s)
[139.050355] [021/131] (884s left) gem_exec_whisper (basic-queues-forked-all)
[139.118352] Starting subtest: basic-queues-forked-all
[159.109253] Subtest basic-queues-forked-all: SUCCESS (19.987s)
[159.317940] [022/131] (864s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[159.425085] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[159.427391] Starting dynamic subtest: pipe-A-eDP-1
[160.242921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.813s)
[160.250901] Starting dynamic subtest: pipe-B-eDP-1
[161.772875] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.523s)
[161.786968] Starting dynamic subtest: pipe-C-eDP-1
[163.243065] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.472s)
[163.252126] Starting dynamic subtest: pipe-D-eDP-1
[164.757544] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.513s)
[164.759504] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.325s)
[165.965380] [023/131] (857s left) kms_content_protection (legacy-hdcp14)
[166.105982] Starting subtest: legacy-hdcp14
[166.110628] Subtest legacy-hdcp14: SKIP (0.000s)
[166.282957] [024/131] (857s left) kms_frontbuffer_tracking (fbc-tiling-y)
[166.391393] Starting subtest: fbc-tiling-y
[166.395831] Subtest fbc-tiling-y: SKIP (0.000s)
[166.535461] [025/131] (857s left) syncobj_wait (single-wait-for-submit-submitted)
[166.599718] Starting subtest: single-wait-for-submit-submitted
[166.707412] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s)
[166.810038] [026/131] (857s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[166.924958] Starting subtest: cursorB-vs-flipB-atomic
[166.929767] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[167.089784] [027/131] (856s left) kms_flip (2x-blocking-absolute-wf_vblank)
[167.189498] Starting subtest: 2x-blocking-absolute-wf_vblank
[167.199905] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[167.296820] [028/131] (856s left) gem_mmap_offset (partial-unmap)
[167.365206] Starting subtest: partial-unmap
[167.367093] Starting dynamic subtest: smem0
[167.854719] Dynamic subtest smem0: SUCCESS (0.489s)
[167.857608] Subtest partial-unmap: SUCCESS (0.490s)
[167.992070] [029/131] (856s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[168.095333] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[175.072380] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.979s)
[175.211289] [030/131] (848s left) kms_vblank (ts-continuation-idle-hang)
[175.297310] Starting subtest: ts-continuation-idle-hang
[175.299593] Starting dynamic subtest: pipe-A-eDP-1
[201.684486] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.384s)
[201.697895] Starting dynamic subtest: pipe-D-eDP-1
[226.651861] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.963s)
[226.654591] Subtest ts-continuation-idle-hang: SUCCESS (51.351s)
[227.533208] [031/131] (796s left) gem_userptr_blits (readonly-unsync)
[227.610981] Subtest readonly-unsync: SKIP (0.000s)
[227.767572] [032/131] (796s left) gem_mmap (short-mmap)
[227.830263] Subtest short-mmap: SKIP (0.000s)
[227.892489] [033/131] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[227.987668] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[227.991831] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[228.122557] [034/131] (796s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[228.223885] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[228.228253] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[228.361990] [035/131] (796s left) kms_chamelium_color (ctm-green-to-red)
[228.466328] Subtest ctm-green-to-red: SKIP (0.000s)
[228.505757] [036/131] (795s left) kms_frontbuffer_tracking (psr-suspend)
[228.627462] Starting subtest: psr-suspend
[266.655280] Subtest psr-suspend: SUCCESS (11.566s)
[266.783409] [037/131] (757s left) gem_spin_batch (engines)
[266.850822] Starting subtest: engines
[266.853345] Starting dynamic subtest: rcs0
[270.246135] Dynamic subtest rcs0: SUCCESS (3.280s)
[270.257038] Starting dynamic subtest: bcs0
[273.652950] Dynamic subtest bcs0: SUCCESS (3.282s)
[273.664260] Starting dynamic subtest: vcs0
[276.956098] Dynamic subtest vcs0: SUCCESS (3.307s)
[276.966630] Starting dynamic subtest: vcs1
[280.352588] Dynamic subtest vcs1: SUCCESS (3.311s)
[280.364010] Starting dynamic subtest: vecs0
[283.695113] Dynamic subtest vecs0: SUCCESS (3.322s)
[283.705655] Starting dynamic subtest: ccs0
[287.033483] Dynamic subtest ccs0: SUCCESS (3.322s)
[287.035898] Subtest engines: SUCCESS (19.841s)
[287.256766] [038/131] (737s left) kms_psr (fbc-pr-sprite-blt)
[287.364160] Starting subtest: fbc-pr-sprite-blt
[287.368266] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[287.461118] [039/131] (737s left) kms_psr (fbc-psr-primary-mmap-gtt)
[287.555694] Starting subtest: fbc-psr-primary-mmap-gtt
[287.557646] Starting dynamic subtest: eDP-1
[287.561740] Dynamic subtest eDP-1: SKIP (0.000s)
[287.565764] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[287.650696] [040/131] (736s left) gem_exec_schedule (preempt-hang)
[287.821077] Starting subtest: preempt-hang
[287.823857] Starting dynamic subtest: rcs0
[288.045237] Dynamic subtest rcs0: SUCCESS (0.222s)
[288.055335] Starting dynamic subtest: bcs0
[288.266693] Dynamic subtest bcs0: SUCCESS (0.220s)
[288.274907] Starting dynamic subtest: vcs0
[288.476728] Dynamic subtest vcs0: SUCCESS (0.209s)
[288.486322] Starting dynamic subtest: vcs1
[288.688570] Dynamic subtest vcs1: SUCCESS (0.210s)
[288.696631] Starting dynamic subtest: vecs0
[288.913824] Dynamic subtest vecs0: SUCCESS (0.224s)
[288.926926] Starting dynamic subtest: ccs0
[289.133817] Dynamic subtest ccs0: SUCCESS (0.219s)
[289.135950] Subtest preempt-hang: SUCCESS (1.310s)
[290.433735] [041/131] (734s left) gem_pxp (create-regular-context-1)
[290.562963] Starting subtest: create-regular-context-1
[290.565341] Subtest create-regular-context-1: SUCCESS (0.002s)
[290.715744] [042/131] (733s left) kms_big_fb (linear-32bpp-rotate-270)
[290.825203] Starting subtest: linear-32bpp-rotate-270
[290.844203] Subtest linear-32bpp-rotate-270: SKIP (0.018s)
[291.008836] [043/131] (733s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[291.110380] Starting subtest: fbc-shrfb-scaledprimary
[294.127678] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.015s)
[295.315436] [044/131] (729s left) kms_getfb (getfb-reject-nv12)
[295.401104] Starting subtest: getfb-reject-nv12
[295.403397] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[295.537725] [045/131] (729s left) gem_exec_parallel (contexts)
[295.588350] Starting subtest: contexts
[295.590587] Starting dynamic subtest: rcs0
[298.592590] Dynamic subtest rcs0: SUCCESS (3.002s)
[298.608239] Starting dynamic subtest: bcs0
[301.987171] Dynamic subtest bcs0: SUCCESS (3.394s)
[301.996112] Starting dynamic subtest: vcs0
[305.725546] Dynamic subtest vcs0: SUCCESS (3.736s)
[305.734754] Starting dynamic subtest: vcs1
[309.805119] Dynamic subtest vcs1: SUCCESS (4.077s)
[309.816503] Starting dynamic subtest: vecs0
[313.808073] Dynamic subtest vecs0: SUCCESS (3.999s)
[313.817620] Starting dynamic subtest: ccs0
[317.371387] Dynamic subtest ccs0: SUCCESS (3.562s)
[317.374008] Subtest contexts: SUCCESS (21.782s)
[317.584753] [046/131] (707s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[317.704243] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[317.708189] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[317.842139] [047/131] (707s left) prime_mmap_coherency (ioctl-errors)
[317.903099] Starting subtest: ioctl-errors
[333.821101] Subtest ioctl-errors: SUCCESS (15.914s)
[334.010859] [048/131] (690s left) kms_3d (basic)
[334.103032] Starting subtest: basic
[336.068911] Subtest basic: SUCCESS (1.966s)
[336.612461] [049/131] (688s left) gem_ctx_param (set-priority-not-supported)
[336.682000] Starting subtest: set-priority-not-supported
[336.686782] Subtest set-priority-not-supported: SKIP (0.000s)
[336.778691] [050/131] (688s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[336.884338] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[336.886681] Starting dynamic subtest: pipe-A-default-mode
[337.172093] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[337.176810] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.286s)
[338.042752] [051/131] (686s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[338.144526] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[338.146919] Starting dynamic subtest: pipe-A-eDP-1
[338.167872] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[338.179815] Starting dynamic subtest: pipe-B-eDP-1
[338.199375] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[338.208130] Starting dynamic subtest: pipe-C-eDP-1
[338.227236] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[338.235471] Starting dynamic subtest: pipe-D-eDP-1
[338.254798] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[338.256705] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.014s)
[340.433738] [052/131] (684s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[345.516127] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[345.520694] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[346.339660] [053/131] (678s left) kms_psr (psr-sprite-mmap-cpu)
[346.428996] Starting subtest: psr-sprite-mmap-cpu
[346.431276] Starting dynamic subtest: eDP-1
[348.218176] Dynamic subtest eDP-1: SUCCESS (1.788s)
[348.220551] Subtest psr-sprite-mmap-cpu: SUCCESS (1.790s)
[349.045364] [054/131] (676s left) syncobj_wait (single-wait-signaled)
[349.107267] Starting subtest: single-wait-signaled
[349.109782] Subtest single-wait-signaled: SUCCESS (0.000s)
[349.225125] [055/131] (675s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[349.317882] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[349.322155] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[349.457948] [056/131] (675s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[349.550266] Starting subtest: bad-aux-stride-yf-tiled-ccs
[349.552557] Starting dynamic subtest: pipe-A-eDP-1
[349.575728] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[349.585565] Starting dynamic subtest: pipe-B-eDP-1
[349.607211] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[349.615656] Starting dynamic subtest: pipe-C-eDP-1
[349.637103] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[349.645718] Starting dynamic subtest: pipe-D-eDP-1
[349.667367] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[349.671358] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[351.834722] [057/131] (673s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[351.944290] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[351.948752] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[352.069443] [058/131] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[352.165872] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[352.170251] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[352.301445] [059/131] (673s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[352.354310] Starting subtest: verify-pxp-stale-buf-optout-execution
[353.416597] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.059s)
[353.582172] [060/131] (671s left) kms_plane (plane-position-hole-dpms)
[353.666405] Starting subtest: plane-position-hole-dpms
[354.172656] Starting dynamic subtest: pipe-A-plane-1
[356.543622] Dynamic subtest pipe-A-plane-1: SUCCESS (2.369s)
[356.554551] Starting dynamic subtest: pipe-A-plane-2
[358.937333] Dynamic subtest pipe-A-plane-2: SUCCESS (2.387s)
[358.947013] Starting dynamic subtest: pipe-A-plane-3
[361.237028] Dynamic subtest pipe-A-plane-3: SUCCESS (2.303s)
[361.247744] Starting dynamic subtest: pipe-A-plane-4
[363.645287] Dynamic subtest pipe-A-plane-4: SUCCESS (2.408s)
[363.654853] Starting dynamic subtest: pipe-A-plane-5
[363.669167] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[364.873467] Starting dynamic subtest: pipe-B-plane-1
[367.252948] Dynamic subtest pipe-B-plane-1: SUCCESS (2.386s)
[367.262466] Starting dynamic subtest: pipe-B-plane-2
[369.669814] Dynamic subtest pipe-B-plane-2: SUCCESS (2.418s)
[369.685225] Starting dynamic subtest: pipe-B-plane-3
[372.025497] Dynamic subtest pipe-B-plane-3: SUCCESS (2.354s)
[372.036519] Starting dynamic subtest: pipe-B-plane-4
[374.323337] Dynamic subtest pipe-B-plane-4: SUCCESS (2.299s)
[374.333406] Starting dynamic subtest: pipe-B-plane-5
[374.349914] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[374.352180] Subtest plane-position-hole-dpms: SUCCESS (20.686s)
[375.138687] [061/131] (650s left) perf (gen12-mi-rpc)
[375.276721] Starting subtest: gen12-mi-rpc
[375.279169] Starting dynamic subtest: rcs0
[375.296283] Dynamic subtest rcs0: SUCCESS (0.017s)
[375.298311] Subtest gen12-mi-rpc: SUCCESS (0.018s)
[375.336480] [062/131] (650s left) gem_ctx_param (invalid-param-set)
[375.435983] Starting subtest: invalid-param-set
[375.438696] Subtest invalid-param-set: SUCCESS (0.000s)
[375.531316] [063/131] (649s left) gem_ctx_shared (q-independent)
[375.585844] Starting subtest: Q-independent
[375.588254] Starting dynamic subtest: rcs0
[375.653382] Dynamic subtest rcs0: SUCCESS (0.066s)
[375.665654] Starting dynamic subtest: vcs0
[375.694403] Dynamic subtest vcs0: SUCCESS (0.041s)
[375.704667] Starting dynamic subtest: vcs1
[375.731034] Dynamic subtest vcs1: SUCCESS (0.036s)
[375.740792] Starting dynamic subtest: vecs0
[375.771145] Dynamic subtest vecs0: SUCCESS (0.039s)
[375.781468] Starting dynamic subtest: ccs0
[375.814618] Dynamic subtest ccs0: SUCCESS (0.043s)
[375.816974] Subtest Q-independent: SUCCESS (0.229s)
[377.463873] [064/131] (648s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[377.556600] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[377.558612] Starting dynamic subtest: pipe-A-eDP-1
[379.638643] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.084s)
[379.650259] Starting dynamic subtest: pipe-B-eDP-1
[381.934215] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.292s)
[381.943102] Starting dynamic subtest: pipe-C-eDP-1
[383.983345] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.050s)
[383.993033] Starting dynamic subtest: pipe-D-eDP-1
[385.980560] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.994s)
[385.982812] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.425s)
[387.274280] [065/131] (638s left) kms_lease (atomic-implicit-crtc)
[387.378260] Starting subtest: atomic-implicit-crtc
[387.380372] Starting dynamic subtest: pipe-A-eDP-1
[387.391395] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[387.401594] Starting dynamic subtest: pipe-B-eDP-1
[387.412716] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[387.421853] Starting dynamic subtest: pipe-C-eDP-1
[387.432736] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[387.441780] Starting dynamic subtest: pipe-D-eDP-1
[387.452419] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[387.454568] Subtest atomic-implicit-crtc: SUCCESS (0.033s)
[387.543061] [066/131] (638s left) gem_exec_reloc (basic-wc)
[387.604729] Subtest basic-wc: SKIP (0.000s)
[387.709926] [067/131] (638s left) syncobj_timeline (transfer-timeline-point)
[387.767664] Starting subtest: transfer-timeline-point
[387.770008] Subtest transfer-timeline-point: SUCCESS (0.001s)
[387.909439] [068/131] (637s left) api_intel_bb (reset-flags)
[387.964592] Starting subtest: reset-flags
[387.972897] Subtest reset-flags: SUCCESS (0.010s)
[388.131812] [069/131] (637s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[388.223264] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[388.225161] Starting dynamic subtest: pipe-A-default-mode
[390.883035] Dynamic subtest pipe-A-default-mode: SUCCESS (2.655s)
[390.885125] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.657s)
[391.731862] [070/131] (634s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[391.832373] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[391.834357] Starting dynamic subtest: pipe-A-eDP-1
[391.973895] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.134s)
[391.985662] Starting dynamic subtest: pipe-B-eDP-1
[392.004878] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[392.014138] Starting dynamic subtest: pipe-C-eDP-1
[392.032754] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[392.041702] Starting dynamic subtest: pipe-D-eDP-1
[392.060703] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[392.062584] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.144s)
[394.336872] [071/131] (631s left) sw_sync (sync_merge_invalid)
[394.376580] Starting subtest: sync_merge_invalid
[394.405547] Subtest sync_merge_invalid: SUCCESS (0.028s)
[394.502204] [072/131] (631s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[394.599399] Starting subtest: yf-tiled-32bpp-rotate-180
[394.603500] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[394.737654] [073/131] (631s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[394.844170] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[401.834732] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.993s)
[402.000213] [074/131] (624s left) gem_userptr_blits (sd-probe)
[402.072381] Starting subtest: sd-probe
[402.074569] Subtest sd-probe: SUCCESS (0.000s)
[402.239668] [075/131] (623s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[402.299917] Subtest no-spare-fences-busy: SKIP (0.000s)
[402.400621] [076/131] (623s left) kms_plane_cursor (viewport)
[402.519475] Starting subtest: viewport
[402.524117] Starting dynamic subtest: pipe-A-eDP-1-size-64
[404.974027] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.453s)
[405.035288] Starting dynamic subtest: pipe-A-eDP-1-size-128
[407.498570] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.471s)
[407.574950] Starting dynamic subtest: pipe-A-eDP-1-size-256
[410.055105] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.504s)
[410.406339] Starting dynamic subtest: pipe-B-eDP-1-size-64
[413.525890] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.129s)
[413.586726] Starting dynamic subtest: pipe-B-eDP-1-size-128
[416.017085] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.437s)
[416.077383] Starting dynamic subtest: pipe-B-eDP-1-size-256
[418.571885] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.504s)
[418.933754] Starting dynamic subtest: pipe-C-eDP-1-size-64
[421.704105] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.785s)
[421.743935] Starting dynamic subtest: pipe-C-eDP-1-size-128
[423.839289] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.103s)
[423.874913] Starting dynamic subtest: pipe-C-eDP-1-size-256
[425.971326] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.102s)
[426.301985] Starting dynamic subtest: pipe-D-eDP-1-size-64
[429.062749] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.772s)
[429.100990] Starting dynamic subtest: pipe-D-eDP-1-size-128
[431.162194] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.069s)
[431.202987] Starting dynamic subtest: pipe-D-eDP-1-size-256
[433.296010] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.102s)
[433.634103] Subtest viewport: SUCCESS (31.108s)
[434.450804] [077/131] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[434.570763] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[434.575120] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[434.692551] [078/131] (591s left) syncobj_timeline (multi-wait-available-signaled)
[434.761006] Starting subtest: multi-wait-available-signaled
[434.763519] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[434.907350] [079/131] (591s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[435.013083] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[435.017530] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[435.147883] [080/131] (591s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[435.218410] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[435.309704] [081/131] (591s left) gem_exec_reloc (basic-cpu-noreloc)
[435.375939] Subtest basic-cpu-noreloc: SKIP (0.000s)
[435.452161] [082/131] (590s left) kms_vblank (crtc-id)
[435.550436] Starting subtest: crtc-id
[435.552012] Starting dynamic subtest: pipe-A-eDP-1
[435.992850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[436.008121] Starting dynamic subtest: pipe-D-eDP-1
[437.107354] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.111s)
[437.109510] Subtest crtc-id: SUCCESS (1.557s)
[437.941550] [083/131] (588s left) gem_exec_balancer (parallel-bb-first)
[438.203818] Starting subtest: parallel-bb-first
[439.100113] Subtest parallel-bb-first: SUCCESS (0.898s)
[440.375949] [084/131] (586s left) syncobj_timeline (device-submit-unordered)
[440.433085] Starting subtest: device-submit-unordered
[440.435685] Subtest device-submit-unordered: SUCCESS (0.000s)
[440.575901] [085/131] (585s left) gem_exec_parallel (userptr)
[440.627839] Starting subtest: userptr
[440.629697] Starting dynamic subtest: rcs0
[442.164126] Dynamic subtest rcs0: SUCCESS (1.539s)
[442.176445] Starting dynamic subtest: bcs0
[443.684000] Dynamic subtest bcs0: SUCCESS (1.516s)
[443.696229] Starting dynamic subtest: vcs0
[445.322362] Dynamic subtest vcs0: SUCCESS (1.634s)
[445.334611] Starting dynamic subtest: vcs1
[447.282403] Dynamic subtest vcs1: SUCCESS (1.959s)
[447.294950] Starting dynamic subtest: vecs0
[449.265879] Dynamic subtest vecs0: SUCCESS (1.980s)
[449.278575] Starting dynamic subtest: ccs0
[450.749245] Dynamic subtest ccs0: SUCCESS (1.482s)
[450.751771] Subtest userptr: SUCCESS (10.123s)
[450.960182] [086/131] (575s left) api_intel_allocator (reopen)
[451.024906] Starting subtest: reopen
[451.030374] Subtest reopen: SUCCESS (0.006s)
[451.188494] [087/131] (575s left) kms_color_pipeline (plane-lut1d-lut1d)
[451.295778] Starting subtest: plane-lut1d-lut1d
[451.308896] Starting dynamic subtest: pipe-A-eDP-1
[452.000590] Dynamic subtest pipe-A-eDP-1: FAIL (0.331s)
[452.671532] Starting dynamic subtest: pipe-B-eDP-1
[453.481314] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[454.064790] Starting dynamic subtest: pipe-C-eDP-1
[454.858940] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[455.370414] Starting dynamic subtest: pipe-D-eDP-1
[456.202320] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[456.204243] Subtest plane-lut1d-lut1d: FAIL (4.601s)
[456.739933] [088/131] (569s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[456.840520] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[461.108905] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.271s)
[462.348023] [089/131] (564s left) kms_flip (flip-vs-absolute-wf_vblank)
[462.441862] Starting subtest: flip-vs-absolute-wf_vblank
[462.443921] Starting dynamic subtest: A-eDP1
[471.331733] Dynamic subtest A-eDP1: SUCCESS (8.889s)
[471.342507] Starting dynamic subtest: B-eDP1
[480.236627] Dynamic subtest B-eDP1: SUCCESS (8.901s)
[480.248253] Starting dynamic subtest: C-eDP1
[489.173856] Dynamic subtest C-eDP1: SUCCESS (8.885s)
[489.185204] Starting dynamic subtest: D-eDP1
[498.079529] Dynamic subtest D-eDP1: SUCCESS (8.905s)
[498.081571] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.592s)
[499.233357] [090/131] (527s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[499.340792] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[499.345224] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[499.471454] [091/131] (527s left) i915_suspend (basic-s2idle-without-i915)
[499.513375] Starting subtest: basic-s2idle-without-i915
[522.014993] Subtest basic-s2idle-without-i915: SUCCESS (7.233s)
[522.131904] [092/131] (504s left) kms_pm_rpm (basic-rte)
[522.179252] Starting subtest: basic-rte
[525.143821] Subtest basic-rte: SUCCESS (2.882s)
[526.581787] [093/131] (500s left) i915_pm_freq_api (freq-reset)
[526.667885] Starting subtest: freq-reset
[526.670834] Starting dynamic subtest: gt0
[526.814804] Dynamic subtest gt0: SUCCESS (0.142s)
[526.823434] Starting dynamic subtest: gt1
[526.944850] Dynamic subtest gt1: SUCCESS (0.128s)
[526.947581] Subtest freq-reset: SUCCESS (0.272s)
[527.047336] [094/131] (499s left) i915_drm_fdinfo (all-busy-idle-check-all)
[527.089975] Starting subtest: all-busy-idle-check-all
[527.097280] Subtest all-busy-idle-check-all: SKIP (0.004s)
[527.214528] [095/131] (499s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[527.314831] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[527.398603] [096/131] (499s left) gen9_exec_parse (basic-rejected-ctx-param)
[527.462960] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[527.533072] [097/131] (499s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[527.625982] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[527.628396] Starting dynamic subtest: pipe-A
[527.646124] Dynamic subtest pipe-A: SKIP (0.017s)
[527.655169] Starting dynamic subtest: pipe-B
[527.678827] Dynamic subtest pipe-B: SKIP (0.031s)
[527.687834] Starting dynamic subtest: pipe-C
[527.712796] Dynamic subtest pipe-C: SKIP (0.032s)
[527.721893] Starting dynamic subtest: pipe-D
[527.745714] Dynamic subtest pipe-D: SKIP (0.032s)
[527.750791] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.114s)
[527.886475] [098/131] (499s left) gem_ctx_isolation (preservation)
[527.949520] Starting subtest: preservation
[527.952316] Starting dynamic subtest: rcs0
[528.085664] Dynamic subtest rcs0: SUCCESS (0.133s)
[528.097027] Starting dynamic subtest: bcs0
[528.264776] Dynamic subtest bcs0: SUCCESS (0.176s)
[528.275449] Starting dynamic subtest: vcs0
[528.433555] Dynamic subtest vcs0: SUCCESS (0.165s)
[528.445893] Starting dynamic subtest: vcs1
[529.591791] Dynamic subtest vcs1: SUCCESS (1.140s)
[529.604160] Starting dynamic subtest: vecs0
[531.644842] Dynamic subtest vecs0: SUCCESS (2.030s)
[531.656048] Starting dynamic subtest: ccs0
[533.655273] Dynamic subtest ccs0: SUCCESS (1.992s)
[533.657730] Subtest preservation: SUCCESS (5.642s)
[533.939198] [099/131] (493s left) kms_feature_discovery (display-2x)
[534.045957] Starting subtest: display-2x
[534.051239] Subtest display-2x: SKIP (0.000s)
[534.141478] [100/131] (493s left) perf_pmu (event-wait)
[534.186985] Starting subtest: event-wait
[534.189734] Starting dynamic subtest: rcs0
[534.194736] Dynamic subtest rcs0: SKIP (0.000s)
[534.199788] Subtest event-wait: SKIP (0.001s)
[534.314089] [101/131] (492s left) gem_ctx_engines (execute-oneforall)
[534.372756] Starting subtest: execute-oneforall
[534.861238] Subtest execute-oneforall: SUCCESS (0.484s)
[536.648895] [102/131] (490s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[536.751463] Starting subtest: y-tiled-64bpp-rotate-0
[536.756493] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[536.883339] [103/131] (490s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[536.937628] Subtest untiled-to-tiled: SKIP (0.000s)
[537.023446] [104/131] (490s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[537.409241] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[538.196550] [105/131] (489s left) gem_mmap (big-bo)
[538.257561] Subtest big-bo: SKIP (0.000s)
[538.309668] [106/131] (489s left) gem_exec_fence (syncobj-signal)
[538.736210] Starting subtest: syncobj-signal
[538.742464] Subtest syncobj-signal: SUCCESS (0.005s)
[540.594486] [107/131] (486s left) kms_cursor_edge_walk (128x128-left-edge)
[540.695369] Starting subtest: 128x128-left-edge
[540.697589] Starting dynamic subtest: pipe-A-eDP-1
[544.208774] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.503s)
[544.218326] Starting dynamic subtest: pipe-D-eDP-1
[547.341526] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[547.344238] Subtest 128x128-left-edge: SUCCESS (6.632s)
[548.189624] [108/131] (479s left) syncobj_wait (single-wait-submitted)
[548.246873] Starting subtest: single-wait-submitted
[548.354266] Subtest single-wait-submitted: SUCCESS (0.107s)
[548.457678] [109/131] (479s left) kms_atomic (plane-invalid-params-fence)
[548.558486] Starting subtest: plane-invalid-params-fence
[548.560805] Starting dynamic subtest: pipe-A-eDP-1
[548.921130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.361s)
[548.923833] Subtest plane-invalid-params-fence: SUCCESS (0.362s)
[549.796194] [110/131] (477s left) gem_exec_await (wide-contexts)
[549.982712] Starting subtest: wide-contexts
[573.342981] Subtest wide-contexts: SUCCESS (23.348s)
[573.563654] [111/131] (454s left) kms_prop_blob (invalid-get-prop)
[573.670064] Starting subtest: invalid-get-prop
[573.672981] Subtest invalid-get-prop: SUCCESS (0.000s)
[573.812530] [112/131] (453s left) kms_psr (psr2-primary-page-flip)
[573.923428] Starting subtest: psr2-primary-page-flip
[573.926141] Starting dynamic subtest: eDP-1
[575.662374] Dynamic subtest eDP-1: SUCCESS (1.740s)
[575.664978] Subtest psr2-primary-page-flip: SUCCESS (1.741s)
[576.555083] [113/131] (451s left) gem_userptr_blits (invalid-null-pointer)
[576.638327] Starting subtest: invalid-null-pointer
[576.640573] Subtest invalid-null-pointer: SUCCESS (0.001s)
[576.802353] [114/131] (450s left) syncobj_timeline (reset-multiple-signaled)
[576.879440] Starting subtest: reset-multiple-signaled
[576.882375] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[577.019556] [115/131] (450s left) gem_exec_async (forked-writes)
[577.074693] Starting subtest: forked-writes
[577.077412] Starting dynamic subtest: rcs0
[577.102259] Dynamic subtest rcs0: SUCCESS (0.028s)
[577.115170] Starting dynamic subtest: bcs0
[577.127005] Dynamic subtest bcs0: SUCCESS (0.023s)
[577.137070] Starting dynamic subtest: vcs0
[577.148784] Dynamic subtest vcs0: SUCCESS (0.021s)
[577.159079] Starting dynamic subtest: vcs1
[577.170562] Dynamic subtest vcs1: SUCCESS (0.021s)
[577.180558] Starting dynamic subtest: vecs0
[577.193103] Dynamic subtest vecs0: SUCCESS (0.022s)
[577.203807] Starting dynamic subtest: ccs0
[577.214977] Dynamic subtest ccs0: SUCCESS (0.021s)
[577.217695] Subtest forked-writes: SUCCESS (0.142s)
[577.490109] [116/131] (450s left) kms_plane_scaling (planes-downscale-factor-0-75)
[577.584446] Starting subtest: planes-downscale-factor-0-75
[577.586929] Starting dynamic subtest: pipe-A
[577.604787] Dynamic subtest pipe-A: SKIP (0.017s)
[577.614557] Starting dynamic subtest: pipe-B
[577.640242] Dynamic subtest pipe-B: SKIP (0.034s)
[577.649852] Starting dynamic subtest: pipe-C
[577.673545] Dynamic subtest pipe-C: SKIP (0.033s)
[577.682893] Starting dynamic subtest: pipe-D
[577.703706] Dynamic subtest pipe-D: SKIP (0.029s)
[577.708618] Subtest planes-downscale-factor-0-75: SKIP (0.116s)
[577.822461] [117/131] (450s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[577.892114] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[577.959358] [118/131] (449s left) dumb_buffer (map-uaf)
[578.024544] Starting subtest: map-uaf
[578.027283] Subtest map-uaf: SUCCESS (0.005s)
[578.167857] [119/131] (449s left) kms_fbcon_fbt (fbc-suspend)
[578.235788] Starting subtest: fbc-suspend
[626.331372] Subtest fbc-suspend: SUCCESS (18.888s)
[627.676344] [120/131] (400s left) perf (blocking)
[627.839171] Starting subtest: blocking
[627.841359] Starting dynamic subtest: 0-rcs0
[637.922750] Dynamic subtest 0-rcs0: SUCCESS (9.917s)
[637.934279] Starting dynamic subtest: 1-vcs1
[647.952606] Dynamic subtest 1-vcs1: SUCCESS (9.995s)
[647.954800] Subtest blocking: SUCCESS (19.914s)
[647.994887] [121/131] (380s left) kms_cursor_crc (cursor-onscreen-128x128)
[648.221155] Starting subtest: cursor-onscreen-128x128
[648.223356] Starting dynamic subtest: pipe-A-eDP-1
[650.367040] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.140s)
[650.398608] Starting dynamic subtest: pipe-D-eDP-1
[653.105660] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.712s)
[653.107647] Subtest cursor-onscreen-128x128: SUCCESS (4.877s)
[653.927892] [122/131] (374s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[654.205747] Starting subtest: cursor-rapid-movement-512x170
[654.210002] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[654.394807] [123/131] (373s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[654.528085] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[655.488057] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.958s)
[656.370599] [124/131] (371s left) gem_exec_schedule (preempt-self)
[656.451900] Starting subtest: preempt-self
[656.454034] Starting dynamic subtest: rcs0
[656.465591] Dynamic subtest rcs0: SUCCESS (0.020s)
[656.475952] Starting dynamic subtest: bcs0
[656.481816] Dynamic subtest bcs0: SUCCESS (0.015s)
[656.490761] Starting dynamic subtest: vcs0
[656.498566] Dynamic subtest vcs0: SUCCESS (0.016s)
[656.507443] Starting dynamic subtest: vcs1
[656.518276] Dynamic subtest vcs1: SUCCESS (0.019s)
[656.527188] Starting dynamic subtest: vecs0
[656.533461] Dynamic subtest vecs0: SUCCESS (0.015s)
[656.542226] Starting dynamic subtest: ccs0
[656.553774] Dynamic subtest ccs0: SUCCESS (0.019s)
[656.556079] Subtest preempt-self: SUCCESS (0.109s)
[658.411800] [125/131] (369s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[658.547665] Starting subtest: x-tiled-64bpp-rotate-180
[660.139446] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.590s)
[660.365742] [126/131] (367s left) kms_flip (2x-flip-vs-modeset)
[660.464766] Starting subtest: 2x-flip-vs-modeset
[660.472414] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[660.617464] [127/131] (367s left) perf_pmu (most-busy-check-all)
[660.663056] Starting subtest: most-busy-check-all
[660.665419] Starting dynamic subtest: rcs0
[662.242719] Dynamic subtest rcs0: SUCCESS (1.580s)
[662.256447] Starting dynamic subtest: bcs0
[664.289697] Dynamic subtest bcs0: SUCCESS (2.043s)
[664.302173] Starting dynamic subtest: vcs0
[666.271926] Dynamic subtest vcs0: SUCCESS (1.980s)
[666.283069] Starting dynamic subtest: vcs1
[668.257787] Dynamic subtest vcs1: SUCCESS (1.982s)
[668.270333] Starting dynamic subtest: vecs0
[670.243488] Dynamic subtest vecs0: SUCCESS (1.982s)
[670.256202] Starting dynamic subtest: ccs0
[672.289186] Dynamic subtest ccs0: SUCCESS (2.041s)
[672.292323] Subtest most-busy-check-all: SUCCESS (11.625s)
[672.440640] [128/131] (355s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[672.837634] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[673.646557] [129/131] (354s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[673.709905] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[673.714497] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[673.923704] [130/131] (354s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[674.030262] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[674.034014] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[674.154647] [131/131] (354s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[674.260950] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[681.031768] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.771s)
[681.201738] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_rotation_crc
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: i915_pm_rc6_residency
results: parsing output: 7/ for test: core_getversion
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_debugfs
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: gem_exec_store
results: parsing output: 12/ for test: gem_exec_flush
results: parsing output: 13/ for test: vgem_basic
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_legacy_colorkey
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_rmfb
results: parsing output: 18/ for test: kms_atomic_interruptible
results: parsing output: 19/ for test: gem_ctx_persistence
results: parsing output: 20/ for test: gem_exec_whisper
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: gem_mmap_offset
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: gem_mmap
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_chamelium_color
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_spin_batch
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: gem_pxp
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_getfb
results: parsing output: 44/ for test: gem_exec_parallel
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: prime_mmap_coherency
results: parsing output: 47/ for test: kms_3d
results: parsing output: 48/ for test: gem_ctx_param
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_pxp
results: parsing output: 59/ for test: kms_plane
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: gem_ctx_param
results: parsing output: 62/ for test: gem_ctx_shared
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: api_intel_bb
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: sw_sync
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: gem_fenced_exec_thrash
results: parsing output: 75/ for test: kms_plane_cursor
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_parallel
results: parsing output: 85/ for test: api_intel_allocator
results: parsing output: 86/ for test: kms_color_pipeline
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: i915_suspend
results: parsing output: 91/ for test: kms_pm_rpm
results: parsing output: 92/ for test: i915_pm_freq_api
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: kms_plane_scaling
results: parsing output: 97/ for test: gem_ctx_isolation
results: parsing output: 98/ for test: kms_feature_discovery
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: gem_ctx_engines
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_set_tiling_vs_blt
results: parsing output: 103/ for test: kms_chamelium_edid
results: parsing output: 104/ for test: gem_mmap
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_cursor_edge_walk
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_atomic
results: parsing output: 109/ for test: gem_exec_await
results: parsing output: 110/ for test: kms_prop_blob
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_exec_async
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: dumb_buffer
results: parsing output: 118/ for test: kms_fbcon_fbt
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: perf_pmu
results: parsing output: 127/ for test: kms_chamelium_hpd
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.