[60.625067] Initializing watchdogs
[60.625150]   /dev/watchdog0
[60.640813] [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.646019] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.648232] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.651613] [001/133] (960s left) kms_chamelium_frames (hdmi-crc-fast)
[61.072957] Subtest hdmi-crc-fast: SKIP (0.000s)
[61.924193] [002/133] (959s left) gem_exec_reloc (basic-concurrent0)
[61.991147] Subtest basic-concurrent0: SKIP (0.000s)
[62.064214] [003/133] (959s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[62.157145] Starting subtest: plane-primary-overlay-mutable-zpos
[65.593677] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.432s)
[66.794288] [004/133] (954s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[66.932227] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[66.936878] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[67.397572] [005/133] (953s left) syncobj_wait (invalid-reset-illegal-handle)
[67.570827] Starting subtest: invalid-reset-illegal-handle
[67.573146] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[67.774989] [006/133] (953s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[67.917395] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[67.919821] Starting dynamic subtest: pipe-A-eDP-1
[67.943306] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[67.951197] Starting dynamic subtest: pipe-B-eDP-1
[67.972839] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[67.980416] Starting dynamic subtest: pipe-C-eDP-1
[68.002135] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.009263] Starting dynamic subtest: pipe-D-eDP-1
[68.031225] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.035243] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[70.238714] [007/133] (951s left) dmabuf_sync_file (import-multiple-read-write)
[70.307069] Starting subtest: import-multiple-read-write
[70.309413] Subtest import-multiple-read-write: SUCCESS (0.003s)
[70.370714] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[70.375375] [008/133] (951s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[70.437909] Starting subtest: multi-wait-for-submit-available-signaled
[70.440278] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[70.549424] [009/133] (950s left) kms_plane_alpha_blend (coverage-7efc)
[70.636663] Starting subtest: coverage-7efc
[70.926064] Starting dynamic subtest: pipe-A-eDP-1
[71.524792] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[71.550847] Starting dynamic subtest: pipe-D-eDP-1
[72.845548] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.300s)
[72.847873] Subtest coverage-7efc: SUCCESS (2.210s)
[73.706668] [010/133] (947s left) kms_psr (fbc-pr-cursor-render)
[73.808879] Starting subtest: fbc-pr-cursor-render
[73.813181] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[73.888885] [011/133] (947s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[73.952588] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[74.037099] [012/133] (947s left) kms_vblank (wait-forked-busy)
[74.131627] Starting subtest: wait-forked-busy
[74.133963] Starting dynamic subtest: pipe-A-eDP-1
[76.019045] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[76.032769] Starting dynamic subtest: pipe-D-eDP-1
[78.565531] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s)
[78.568056] Subtest wait-forked-busy: SUCCESS (4.433s)
[79.372556] [013/133] (942s left) kms_plane_lowres (tiling-y)
[79.471508] Starting subtest: tiling-y
[79.476087] Subtest tiling-y: SKIP (0.000s)
[79.554388] [014/133] (942s left) kms_flip (2x-flip-vs-dpms)
[79.654997] Starting subtest: 2x-flip-vs-dpms
[79.666862] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[79.755587] [015/133] (941s left) prime_mmap (test_reprime)
[79.810711] Starting subtest: test_reprime
[79.812592] Starting dynamic subtest: test_reprime-smem
[79.840302] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[79.842670] Subtest test_reprime: SUCCESS (0.032s)
[79.950050] [016/133] (941s left) gem_ctx_param (invalid-ctx-set)
[80.009499] Starting subtest: invalid-ctx-set
[80.011515] Subtest invalid-ctx-set: SUCCESS (0.002s)
[80.121599] [017/133] (941s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[80.171477] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[80.272041] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[80.359026] [018/133] (941s left) kms_atomic_interruptible (legacy-pageflip)
[80.457175] Starting subtest: legacy-pageflip
[80.459315] Starting dynamic subtest: pipe-A-eDP-1
[87.883325] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.425s)
[87.885633] Subtest legacy-pageflip: SUCCESS (7.426s)
[88.739485] [019/133] (933s left) gem_exec_balancer (invalid-bonds)
[88.822042] Starting subtest: invalid-bonds
[88.826623] Subtest invalid-bonds: SKIP (0.000s)
[89.131090] [020/133] (932s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[89.233058] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[89.237241] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[89.344553] [021/133] (932s left) syncobj_wait (wait-delayed-signal)
[89.400404] Starting subtest: wait-delayed-signal
[89.504348] Subtest wait-delayed-signal: SUCCESS (0.103s)
[89.588833] [022/133] (932s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[89.685100] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[89.687474] Starting dynamic subtest: pipe-A
[89.705939] Dynamic subtest pipe-A: SKIP (0.017s)
[89.714267] Starting dynamic subtest: pipe-B
[89.737080] Dynamic subtest pipe-B: SKIP (0.031s)
[89.744262] Starting dynamic subtest: pipe-C
[89.767605] Dynamic subtest pipe-C: SKIP (0.031s)
[89.774501] Starting dynamic subtest: pipe-D
[89.798839] Dynamic subtest pipe-D: SKIP (0.031s)
[89.803158] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.111s)
[89.928217] [023/133] (932s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[90.042316] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[97.453481] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.412s)
[97.597033] [024/133] (924s left) kms_cursor_edge_walk (128x128-top-edge)
[97.699327] Starting subtest: 128x128-top-edge
[97.701519] Starting dynamic subtest: pipe-A-eDP-1
[101.128609] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.429s)
[101.136909] Starting dynamic subtest: pipe-D-eDP-1
[104.238500] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.109s)
[104.240844] Subtest 128x128-top-edge: SUCCESS (6.540s)
[105.090230] [025/133] (917s left) kms_psr (pr-sprite-render)
[105.186172] Starting subtest: pr-sprite-render
[105.190182] Subtest pr-sprite-render: SKIP (0.000s)
[105.268361] [026/133] (916s left) gem_exec_nop (basic-series)
[105.350474] Starting subtest: basic-series
[121.882467] Subtest basic-series: SUCCESS (16.541s)
[122.155631] [027/133] (900s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[122.289287] Starting subtest: cursorA-vs-flipA-atomic
[133.414825] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.126s)
[134.299962] [028/133] (887s left) gem_userptr_blits (mmap-offset-banned)
[134.367414] Starting subtest: mmap-offset-banned
[134.369386] Starting dynamic subtest: wb
[134.371365] Dynamic subtest wb: SUCCESS (0.000s)
[134.380605] Starting dynamic subtest: wc
[134.382794] Dynamic subtest wc: SUCCESS (0.000s)
[134.389940] Starting dynamic subtest: uc
[134.392154] Dynamic subtest uc: SUCCESS (0.000s)
[134.394300] Subtest mmap-offset-banned: SUCCESS (0.001s)
[134.506779] [029/133] (887s left) kms_big_fb (linear-16bpp-rotate-0)
[134.611312] Starting subtest: linear-16bpp-rotate-0
[135.945739] Subtest linear-16bpp-rotate-0: SUCCESS (1.334s)
[136.091830] [030/133] (886s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[136.186022] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[136.189468] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[136.311259] [031/133] (886s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[136.409119] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[136.412595] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[136.526983] [032/133] (885s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[136.610567] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[136.639019] Starting dynamic subtest: pipe-A-plane-0
[136.642833] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[136.651855] Starting dynamic subtest: pipe-A-plane-3
[136.655569] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[136.662246] Starting dynamic subtest: pipe-A-plane-5
[136.665730] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[137.771986] Starting dynamic subtest: pipe-B-plane-0
[137.776109] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[137.784611] Starting dynamic subtest: pipe-B-plane-3
[137.789129] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[137.797799] Starting dynamic subtest: pipe-B-plane-5
[137.802375] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[138.097371] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (1.485s)
[138.968065] [033/133] (883s left) perf (oa-exponents)
[139.095478] Starting subtest: oa-exponents
[139.097808] Starting dynamic subtest: 0-rcs0
[140.882054] Dynamic subtest 0-rcs0: SUCCESS (1.785s)
[140.890331] Starting dynamic subtest: 1-vecs0
[142.706677] Dynamic subtest 1-vecs0: SUCCESS (1.824s)
[142.709121] Subtest oa-exponents: SUCCESS (3.610s)
[142.755545] [034/133] (879s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[142.859971] Starting subtest: crc-primary-basic-y-tiled-ccs
[142.862365] Starting dynamic subtest: pipe-A-eDP-1
[142.886093] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[142.896025] Starting dynamic subtest: pipe-B-eDP-1
[142.918623] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[142.926027] Starting dynamic subtest: pipe-C-eDP-1
[142.948326] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[142.955508] Starting dynamic subtest: pipe-D-eDP-1
[142.977582] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[142.981660] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[145.043739] [035/133] (877s left) gem_userptr_blits (process-exit-busy)
[145.120423] Starting subtest: process-exit-busy
[145.131421] Subtest process-exit-busy: SUCCESS (0.011s)
[145.280245] [036/133] (877s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[145.346458] Starting subtest: y-tiled-to-vebox-y-tiled
[145.350675] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[145.539123] [037/133] (877s left) gem_userptr_blits (forbidden-operations)
[145.615672] Starting subtest: forbidden-operations
[145.620058] Subtest forbidden-operations: SKIP (0.000s)
[145.754101] [038/133] (876s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[145.849282] Starting subtest: fbc-psr2-sprite-mmap-gtt
[145.851565] Starting dynamic subtest: eDP-1
[145.855978] Dynamic subtest eDP-1: SKIP (0.000s)
[145.860323] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[145.946606] [039/133] (876s left) kms_pm_dc (dc6-dpms)
[147.056061] Starting subtest: dc6-dpms
[149.109856] Subtest dc6-dpms: SUCCESS (2.053s)
[149.196652] [040/133] (873s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[149.264173] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[149.369249] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[149.454086] [041/133] (873s left) i915_drm_fdinfo (virtual-busy)
[149.490858] Starting subtest: virtual-busy
[149.495326] Subtest virtual-busy: SKIP (0.000s)
[149.560173] [042/133] (873s left) gem_busy (parallel)
[149.754832] Starting subtest: parallel
[149.757069] Starting dynamic subtest: rcs0
[150.933460] Dynamic subtest rcs0: SUCCESS (1.176s)
[150.943888] Starting dynamic subtest: bcs0
[152.917881] Dynamic subtest bcs0: SUCCESS (1.983s)
[152.927924] Starting dynamic subtest: vcs0
[154.901962] Dynamic subtest vcs0: SUCCESS (1.981s)
[154.913662] Starting dynamic subtest: vcs1
[156.884686] Dynamic subtest vcs1: SUCCESS (1.981s)
[156.895240] Starting dynamic subtest: vecs0
[158.932457] Dynamic subtest vecs0: SUCCESS (2.046s)
[158.945317] Starting dynamic subtest: ccs0
[160.916333] Dynamic subtest ccs0: SUCCESS (1.982s)
[160.919584] Subtest parallel: SUCCESS (11.160s)
[161.184786] [043/133] (861s left) kms_cursor_crc (cursor-random-64x64)
[161.366295] Starting subtest: cursor-random-64x64
[161.371161] Starting dynamic subtest: pipe-A-eDP-1
[164.713670] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.342s)
[164.741186] Starting dynamic subtest: pipe-D-eDP-1
[168.774748] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.038s)
[168.777187] Subtest cursor-random-64x64: SUCCESS (7.406s)
[169.642779] [044/133] (853s left) gem_exec_schedule (preempt-other-chain)
[169.708839] Starting subtest: preempt-other-chain
[169.710998] Starting dynamic subtest: rcs0
[169.788615] Dynamic subtest rcs0: SUCCESS (0.086s)
[169.796660] Starting dynamic subtest: bcs0
[169.874525] Dynamic subtest bcs0: SUCCESS (0.085s)
[169.883626] Starting dynamic subtest: vcs0
[169.951646] Dynamic subtest vcs0: SUCCESS (0.077s)
[169.962913] Starting dynamic subtest: vcs1
[170.026077] Dynamic subtest vcs1: SUCCESS (0.074s)
[170.037557] Starting dynamic subtest: vecs0
[170.101491] Dynamic subtest vecs0: SUCCESS (0.075s)
[170.114118] Starting dynamic subtest: ccs0
[170.177484] Dynamic subtest ccs0: SUCCESS (0.076s)
[170.180058] Subtest preempt-other-chain: SUCCESS (0.475s)
[171.025972] [045/133] (851s left) kms_pm_rpm (modeset-stress-extra-wait)
[173.065231] Starting subtest: modeset-stress-extra-wait
[227.319718] Subtest modeset-stress-extra-wait: SUCCESS (54.255s)
[227.420088] [046/133] (795s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[227.522693] Starting subtest: y-tiled-16bpp-rotate-90
[227.526732] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[227.647935] [047/133] (795s left) kms_color_pipeline (plane-lut1d-lut1d)
[227.740158] Starting subtest: plane-lut1d-lut1d
[227.753462] Starting dynamic subtest: pipe-A-eDP-1
[228.463108] Dynamic subtest pipe-A-eDP-1: FAIL (0.338s)
[229.150688] Starting dynamic subtest: pipe-B-eDP-1
[229.987067] Dynamic subtest pipe-B-eDP-1: FAIL (0.304s)
[230.483094] Starting dynamic subtest: pipe-C-eDP-1
[231.328374] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[231.806766] Starting dynamic subtest: pipe-D-eDP-1
[232.631887] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[232.634226] Subtest plane-lut1d-lut1d: FAIL (4.598s)
[233.200820] [048/133] (789s left) syncobj_timeline (wait-zero-handles)
[233.255297] Starting subtest: wait-zero-handles
[233.257627] Subtest wait-zero-handles: SUCCESS (0.000s)
[233.362463] [049/133] (789s left) kms_flip (flip-vs-panning-interruptible)
[233.459194] Starting subtest: flip-vs-panning-interruptible
[233.461453] Starting dynamic subtest: A-eDP1
[242.211543] Dynamic subtest A-eDP1: SUCCESS (8.752s)
[242.219532] Starting dynamic subtest: B-eDP1
[250.938911] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[250.947644] Starting dynamic subtest: C-eDP1
[259.650132] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[259.658523] Starting dynamic subtest: D-eDP1
[268.283901] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[268.288083] Subtest flip-vs-panning-interruptible: SUCCESS (34.828s)
[269.560919] [050/133] (753s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[269.656418] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[269.660778] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[269.732401] [051/133] (753s left) kms_mmap_write_crc (main)
[269.835884] Starting subtest: main
[269.838469] Starting dynamic subtest: pipe-A-eDP-1
[273.251780] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.413s)
[273.254106] Subtest main: SUCCESS (3.415s)
[274.116993] [052/133] (749s left) kms_flip (basic-flip-vs-dpms)
[274.222842] Starting subtest: basic-flip-vs-dpms
[274.224982] Starting dynamic subtest: A-eDP1
[276.791676] Dynamic subtest A-eDP1: SUCCESS (2.567s)
[276.800258] Starting dynamic subtest: B-eDP1
[278.974059] Dynamic subtest B-eDP1: SUCCESS (2.183s)
[278.982106] Starting dynamic subtest: C-eDP1
[281.127143] Dynamic subtest C-eDP1: SUCCESS (2.154s)
[281.135253] Starting dynamic subtest: D-eDP1
[283.221839] Dynamic subtest D-eDP1: SUCCESS (2.092s)
[283.224120] Subtest basic-flip-vs-dpms: SUCCESS (9.002s)
[284.028580] [053/133] (739s left) gen9_exec_parse (bb-oversize)
[284.098314] Subtest bb-oversize: SKIP (0.000s)
[284.192392] [054/133] (739s left) gem_exec_fence (expired-history)
[284.635727] Starting subtest: expired-history
[291.682444] Subtest expired-history: SUCCESS (7.046s)
[292.318297] [055/133] (730s left) gem_ctx_persistence (engines-cleanup)
[292.377588] Starting subtest: engines-cleanup
[292.379945] Starting dynamic subtest: rcs0
[292.457530] Dynamic subtest rcs0: SUCCESS (0.079s)
[292.468107] Starting dynamic subtest: bcs0
[292.524687] Dynamic subtest bcs0: SUCCESS (0.066s)
[292.534935] Starting dynamic subtest: vcs0
[292.573728] Dynamic subtest vcs0: SUCCESS (0.048s)
[292.583073] Starting dynamic subtest: vcs1
[292.641804] Dynamic subtest vcs1: SUCCESS (0.066s)
[292.652216] Starting dynamic subtest: vecs0
[292.669401] Dynamic subtest vecs0: SUCCESS (0.026s)
[292.676620] Starting dynamic subtest: ccs0
[292.760870] Dynamic subtest ccs0: SUCCESS (0.090s)
[292.763560] Subtest engines-cleanup: SUCCESS (0.384s)
[292.852895] [056/133] (730s left) perf_pmu (all-busy-check-all)
[292.897376] Starting subtest: all-busy-check-all
[294.933598] Subtest all-busy-check-all: SUCCESS (2.036s)
[295.060319] [057/133] (728s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[295.162763] Starting subtest: async-flip-with-page-flip-events-tiled
[295.539280] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[298.298809] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.758s)
[298.307872] Starting dynamic subtest: pipe-A-eDP-1-4
[300.474593] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[300.485887] Starting dynamic subtest: pipe-A-eDP-1-4
[302.484736] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[302.495968] Starting dynamic subtest: pipe-A-eDP-1-x
[304.663492] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[305.031180] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[307.823811] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[307.836659] Starting dynamic subtest: pipe-B-eDP-1-4
[310.022435] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[310.030961] Starting dynamic subtest: pipe-B-eDP-1-4
[312.033381] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[312.042155] Starting dynamic subtest: pipe-B-eDP-1-x
[314.233940] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[314.608295] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[317.360444] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.757s)
[317.371874] Starting dynamic subtest: pipe-C-eDP-1-4
[319.524152] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s)
[319.537356] Starting dynamic subtest: pipe-C-eDP-1-4
[321.534598] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[321.545598] Starting dynamic subtest: pipe-C-eDP-1-x
[323.712672] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[324.076490] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[326.806307] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.735s)
[326.817374] Starting dynamic subtest: pipe-D-eDP-1-4
[328.981256] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[328.992084] Starting dynamic subtest: pipe-D-eDP-1-4
[330.991247] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[330.999816] Starting dynamic subtest: pipe-D-eDP-1-x
[333.180872] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[333.183434] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.016s)
[334.404202] [058/133] (689s left) gem_eio (in-flight-contexts-1us)
[334.636920] Starting subtest: in-flight-contexts-1us
[345.895079] Subtest in-flight-contexts-1us: SUCCESS (11.258s)
[346.084519] [059/133] (677s left) gem_mmap_wc (read-write-distinct)
[346.168624] Subtest read-write-distinct: SKIP (0.000s)
[346.237320] [060/133] (677s left) gem_render_copy (yf-tiled-ccs-to-linear)
[346.297145] Starting subtest: yf-tiled-ccs-to-linear
[346.301669] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[346.487879] [061/133] (677s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[346.549938] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[346.636345] [062/133] (676s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[346.742300] Starting subtest: fbcpsr-rgb565-draw-render
[353.795945] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.054s)
[353.967178] [063/133] (669s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[354.079323] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[354.737102] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[354.932512] [064/133] (668s left) api_intel_bb (simple-bb-ctx)
[354.996590] Starting subtest: simple-bb-ctx
[355.003393] Subtest simple-bb-ctx: SUCCESS (0.008s)
[355.145272] [065/133] (668s left) api_intel_allocator (simple-allocator)
[355.202530] Starting subtest: simple-allocator
[355.204859] Starting dynamic subtest: basic
[355.206849] Dynamic subtest basic: SUCCESS (0.004s)
[355.219991] Starting dynamic subtest: parallel-one
[355.399959] Dynamic subtest parallel-one: SUCCESS (0.194s)
[355.411448] Starting dynamic subtest: print
[355.413297] Dynamic subtest print: SUCCESS (0.000s)
[355.421978] Starting dynamic subtest: reuse
[355.424145] Dynamic subtest reuse: SUCCESS (0.000s)
[355.432322] Starting dynamic subtest: reserve
[355.434528] Dynamic subtest reserve: SUCCESS (0.000s)
[355.442853] Starting dynamic subtest: fork-reopen-allocator
[355.445092] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[355.447207] Subtest simple-allocator: SUCCESS (0.216s)
[355.553514] [066/133] (668s left) kms_psr (fbc-psr2-cursor-render)
[355.649824] Starting subtest: fbc-psr2-cursor-render
[355.652114] Starting dynamic subtest: eDP-1
[355.656112] Dynamic subtest eDP-1: SKIP (0.000s)
[355.660127] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[355.734135] [067/133] (668s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[355.829035] Starting subtest: psr-rgb101010-draw-mmap-gtt
[355.833180] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[355.949794] [068/133] (667s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[356.339227] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[357.113367] [069/133] (666s left) kms_invalid_mode (int-max-clock)
[357.214198] Starting subtest: int-max-clock
[357.216589] Starting dynamic subtest: pipe-A-eDP-1
[357.508207] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[357.519545] Starting dynamic subtest: pipe-B-eDP-1
[357.521566] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[357.530033] Starting dynamic subtest: pipe-C-eDP-1
[357.532355] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[357.540988] Starting dynamic subtest: pipe-D-eDP-1
[357.543465] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[357.545771] Subtest int-max-clock: SUCCESS (0.299s)
[358.398415] [070/133] (665s left) kms_draw_crc (draw-method-pwrite)
[358.501955] Starting subtest: draw-method-pwrite
[358.504259] Starting dynamic subtest: xrgb8888-untiled
[359.082190] Dynamic subtest xrgb8888-untiled: SUCCESS (0.578s)
[359.090895] Starting dynamic subtest: rgb565-untiled
[359.523664] Dynamic subtest rgb565-untiled: SUCCESS (0.442s)
[359.533369] Starting dynamic subtest: xrgb2101010-untiled
[360.068216] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[360.077295] Starting dynamic subtest: xbgr16161616f-untiled
[360.835071] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.766s)
[360.844151] Starting dynamic subtest: xrgb8888-xtiled
[362.612960] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.777s)
[362.621979] Starting dynamic subtest: rgb565-xtiled
[363.679363] Dynamic subtest rgb565-xtiled: SUCCESS (1.064s)
[363.690386] Starting dynamic subtest: xrgb2101010-xtiled
[365.435202] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.755s)
[365.447691] Starting dynamic subtest: xbgr16161616f-xtiled
[368.735645] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.299s)
[368.747240] Starting dynamic subtest: xrgb8888-4tiled
[369.846310] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.110s)
[369.855206] Starting dynamic subtest: rgb565-4tiled
[370.390522] Dynamic subtest rgb565-4tiled: SUCCESS (0.544s)
[370.399542] Starting dynamic subtest: xrgb2101010-4tiled
[371.457728] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.066s)
[371.467410] Starting dynamic subtest: xbgr16161616f-4tiled
[374.479785] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.021s)
[374.481925] Subtest draw-method-pwrite: SUCCESS (15.979s)
[374.599947] [071/133] (649s left) kms_frontbuffer_tracking (basic)
[374.706406] Starting subtest: basic
[377.795948] Subtest basic: SUCCESS (3.094s)
[377.904599] [072/133] (646s left) gem_userptr_blits (readonly-unsync)
[377.984416] Subtest readonly-unsync: SKIP (0.000s)
[378.133540] [073/133] (645s left) syncobj_timeline (invalid-signal-zero-handles)
[378.198999] Starting subtest: invalid-signal-zero-handles
[378.201203] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[378.317374] [074/133] (645s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[378.412991] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[379.248784] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.837s)
[379.433243] [075/133] (644s left) kms_universal_plane (cursor-fb-leak)
[379.543111] Starting subtest: cursor-fb-leak
[379.545437] Starting dynamic subtest: pipe-A-eDP-1
[379.878715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.337s)
[379.889156] Starting dynamic subtest: pipe-B-eDP-1
[381.269786] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s)
[381.284472] Starting dynamic subtest: pipe-C-eDP-1
[382.598329] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.326s)
[382.609525] Starting dynamic subtest: pipe-D-eDP-1
[383.918366] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[383.920748] Subtest cursor-fb-leak: SUCCESS (4.378s)
[385.108931] [076/133] (639s left) gem_mmap_offset (partial-remap)
[385.168122] Starting subtest: partial-remap
[385.170040] Starting dynamic subtest: smem0
[385.178774] Dynamic subtest smem0: SUCCESS (0.004s)
[385.180674] Subtest partial-remap: SUCCESS (0.005s)
[385.323384] [077/133] (638s left) gem_exec_fence (syncobj-signal)
[385.782622] Starting subtest: syncobj-signal
[385.788480] Subtest syncobj-signal: SUCCESS (0.005s)
[387.017292] [078/133] (637s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[387.120622] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[387.133101] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[387.278560] [079/133] (637s left) gem_exec_reloc (basic-write-wc)
[387.335417] Subtest basic-write-wc: SKIP (0.000s)
[387.397431] [080/133] (636s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[387.498136] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[387.502289] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[387.618942] [081/133] (636s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[387.723757] Starting subtest: yf-tiled-8bpp-rotate-180
[387.728160] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[387.843449] [082/133] (636s left) gem_lmem_swapping (verify)
[387.893367] Subtest verify: SKIP (0.000s)
[387.939379] [083/133] (636s left) kms_psr (psr2-primary-mmap-gtt)
[388.026439] Starting subtest: psr2-primary-mmap-gtt
[388.028097] Starting dynamic subtest: eDP-1
[389.473482] Dynamic subtest eDP-1: SKIP (1.444s)
[389.478294] Subtest psr2-primary-mmap-gtt: SKIP (1.447s)
[389.647470] [084/133] (634s left) kms_flip (flip-vs-suspend-interruptible)
[389.735221] Starting subtest: flip-vs-suspend-interruptible
[389.737517] Starting dynamic subtest: A-eDP1
[422.799666] Dynamic subtest A-eDP1: SUCCESS (4.348s)
[422.815409] Starting dynamic subtest: B-eDP1
[471.791816] Dynamic subtest B-eDP1: SUCCESS (4.534s)
[471.802566] Starting dynamic subtest: C-eDP1
[520.805253] Dynamic subtest C-eDP1: SUCCESS (4.530s)
[520.816253] Starting dynamic subtest: D-eDP1
[569.796070] Dynamic subtest D-eDP1: SUCCESS (4.503s)
[569.797916] Subtest flip-vs-suspend-interruptible: SUCCESS (17.923s)
[570.995380] [085/133] (453s left) gem_create (create-ext-cpu-access-sanity-check)
[571.179942] Starting subtest: create-ext-cpu-access-sanity-check
[571.185134] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[571.268772] [086/133] (453s left) kms_dp_aux_dev
[571.646810] [087/133] (452s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[571.743075] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[571.747123] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[571.861686] [088/133] (452s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[571.965452] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[571.969420] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[572.048244] [089/133] (452s left) gem_exec_schedule (smoketest)
[572.232151] Starting subtest: smoketest
[572.234505] Starting dynamic subtest: rcs0
[577.754316] Dynamic subtest rcs0: SUCCESS (5.468s)
[577.765966] Starting dynamic subtest: bcs0
[583.242132] Dynamic subtest bcs0: SUCCESS (5.478s)
[583.253355] Starting dynamic subtest: vcs0
[588.736701] Dynamic subtest vcs0: SUCCESS (5.489s)
[588.748442] Starting dynamic subtest: vcs1
[594.240977] Dynamic subtest vcs1: SUCCESS (5.503s)
[594.256992] Starting dynamic subtest: vecs0
[599.742332] Dynamic subtest vecs0: SUCCESS (5.496s)
[599.758483] Starting dynamic subtest: ccs0
[605.241108] Dynamic subtest ccs0: SUCCESS (5.493s)
[605.243059] Subtest smoketest: SUCCESS (32.936s)
[605.390970] [090/133] (419s left) gem_spin_batch (resubmit-new-all)
[605.456032] Starting subtest: resubmit-new-all
[605.458273] Starting dynamic subtest: rcs0
[605.478575] Dynamic subtest rcs0: SUCCESS (0.023s)
[605.490961] Starting dynamic subtest: bcs0
[605.495832] Dynamic subtest bcs0: SUCCESS (0.016s)
[605.505521] Starting dynamic subtest: vcs0
[605.510202] Dynamic subtest vcs0: SUCCESS (0.014s)
[605.519870] Starting dynamic subtest: vcs1
[605.524331] Dynamic subtest vcs1: SUCCESS (0.013s)
[605.533929] Starting dynamic subtest: vecs0
[605.539083] Dynamic subtest vecs0: SUCCESS (0.014s)
[605.552881] Starting dynamic subtest: ccs0
[605.558864] Dynamic subtest ccs0: SUCCESS (0.019s)
[605.561225] Subtest resubmit-new-all: SUCCESS (0.104s)
[607.054887] [091/133] (417s left) kms_rotation_crc (exhaust-fences)
[607.159246] Starting subtest: exhaust-fences
[607.163354] Subtest exhaust-fences: SKIP (0.000s)
[607.260163] [092/133] (417s left) perf (sysctl-defaults)
[607.342135] Starting subtest: sysctl-defaults
[607.344978] Subtest sysctl-defaults: SUCCESS (0.000s)
[607.402105] [093/133] (417s left) perf_pmu (most-busy-idle-check-all)
[607.441477] Starting subtest: most-busy-idle-check-all
[607.443448] Starting dynamic subtest: rcs0
[609.040280] Dynamic subtest rcs0: SUCCESS (1.601s)
[609.056280] Starting dynamic subtest: bcs0
[611.023172] Dynamic subtest bcs0: SUCCESS (1.980s)
[611.036192] Starting dynamic subtest: vcs0
[613.008151] Dynamic subtest vcs0: SUCCESS (1.981s)
[613.020894] Starting dynamic subtest: vcs1
[614.992163] Dynamic subtest vcs1: SUCCESS (1.980s)
[615.005012] Starting dynamic subtest: vecs0
[617.040341] Dynamic subtest vecs0: SUCCESS (2.044s)
[617.053169] Starting dynamic subtest: ccs0
[619.024016] Dynamic subtest ccs0: SUCCESS (1.980s)
[619.027123] Subtest most-busy-idle-check-all: SUCCESS (11.581s)
[619.151941] [094/133] (405s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[619.262799] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[619.267215] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[619.390485] [095/133] (405s left) i915_pm_rc6_residency (rc6-fence)
[619.445669] Starting subtest: rc6-fence
[619.471202] Starting dynamic subtest: gt0
[631.795278] Dynamic subtest gt0: SUCCESS (12.317s)
[631.806525] Starting dynamic subtest: gt1
[646.992123] Dynamic subtest gt1: SUCCESS (15.186s)
[646.994776] Subtest rc6-fence: SUCCESS (27.536s)
[647.098634] [096/133] (377s left) sriov_basic (enable-vfs-autoprobe-off)
[647.157436] Starting subtest: enable-vfs-autoprobe-off
[647.159564] Starting dynamic subtest: numvfs-1
[647.232401] Dynamic subtest numvfs-1: FAIL (0.005s)
[647.246833] Starting dynamic subtest: numvfs-2
[647.320530] Dynamic subtest numvfs-2: FAIL (0.004s)
[647.331604] Starting dynamic subtest: numvfs-3
[647.403300] Dynamic subtest numvfs-3: FAIL (0.004s)
[647.414143] Starting dynamic subtest: numvfs-4
[647.485606] Dynamic subtest numvfs-4: FAIL (0.004s)
[647.497316] Starting dynamic subtest: numvfs-5
[647.569775] Dynamic subtest numvfs-5: FAIL (0.004s)
[647.580471] Starting dynamic subtest: numvfs-6
[647.651896] Dynamic subtest numvfs-6: FAIL (0.004s)
[647.662633] Starting dynamic subtest: numvfs-7
[647.736330] Dynamic subtest numvfs-7: FAIL (0.004s)
[647.747027] Starting dynamic subtest: numvfs-random
[647.818906] Dynamic subtest numvfs-random: FAIL (0.004s)
[647.830081] Starting dynamic subtest: numvfs-all
[647.903491] Dynamic subtest numvfs-all: FAIL (0.516s)
[647.905485] Subtest enable-vfs-autoprobe-off: FAIL (0.555s)
[647.945212] [097/133] (377s left) kms_cursor_crc (cursor-offscreen-64x21)
[648.138321] Starting subtest: cursor-offscreen-64x21
[648.186325] Subtest cursor-offscreen-64x21: SKIP (0.044s)
[648.468901] [098/133] (376s left) gem_lmem_swapping (parallel-multi)
[648.508489] Subtest parallel-multi: SKIP (0.000s)
[648.560302] [099/133] (376s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[648.672705] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[648.676332] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[648.808765] [100/133] (376s left) perf (global-sseu-config-invalid)
[648.902714] Starting subtest: global-sseu-config-invalid
[648.906529] Subtest global-sseu-config-invalid: SKIP (0.000s)
[648.951954] [101/133] (376s left) syncobj_timeline (wait-all-complex)
[649.017183] Starting subtest: wait-all-complex
[649.230877] Subtest wait-all-complex: SUCCESS (0.213s)
[649.320564] [102/133] (375s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[649.431582] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[656.119992] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.684s)
[656.279601] [103/133] (369s left) gem_render_copy_redux (flink)
[656.355285] Starting subtest: flink
[657.084581] Subtest flink: SUCCESS (0.732s)
[657.251594] [104/133] (368s left) syncobj_wait (wait-all-complex)
[657.310531] Starting subtest: wait-all-complex
[657.524873] Subtest wait-all-complex: SUCCESS (0.212s)
[657.626656] [105/133] (367s left) gem_userptr_blits (create-destroy-sync)
[657.692829] Starting subtest: create-destroy-sync
[662.710328] Subtest create-destroy-sync: SUCCESS (5.016s)
[662.867598] [106/133] (362s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[662.966489] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[662.970737] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[663.079392] [107/133] (362s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[663.142319] Starting subtest: multi-wait-for-submit-submitted-signaled
[663.144502] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[663.246515] [108/133] (362s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[663.348983] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[663.352926] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[663.447964] [109/133] (362s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[663.539324] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[663.566214] Starting dynamic subtest: pipe-A-plane-0
[663.570782] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[663.580539] Starting dynamic subtest: pipe-A-plane-3
[663.584958] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[663.594543] Starting dynamic subtest: pipe-A-plane-5
[663.598558] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[664.632053] Starting dynamic subtest: pipe-B-plane-0
[664.636395] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[664.646132] Starting dynamic subtest: pipe-B-plane-3
[664.650766] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[664.660500] Starting dynamic subtest: pipe-B-plane-5
[664.664860] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[664.936732] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (1.397s)
[665.810546] [110/133] (359s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[665.909471] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[665.913927] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[666.008097] [111/133] (359s left) gem_exec_reloc (basic-cpu-wc-active)
[666.066692] Subtest basic-cpu-wc-active: SKIP (0.000s)
[666.157994] [112/133] (359s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[666.215742] Starting subtest: saturated-hostile-nopreempt
[666.218192] Starting dynamic subtest: rcs0
[666.315321] Dynamic subtest rcs0: SKIP (0.096s)
[666.327971] Starting dynamic subtest: bcs0
[666.343124] Dynamic subtest bcs0: SKIP (0.027s)
[666.352479] Starting dynamic subtest: vcs0
[666.367886] Dynamic subtest vcs0: SKIP (0.023s)
[666.377447] Starting dynamic subtest: vcs1
[666.387692] Dynamic subtest vcs1: SKIP (0.019s)
[666.397271] Starting dynamic subtest: vecs0
[666.408741] Dynamic subtest vecs0: SKIP (0.020s)
[666.418437] Starting dynamic subtest: ccs0
[666.428738] Dynamic subtest ccs0: SKIP (0.019s)
[666.432925] Subtest saturated-hostile-nopreempt: SKIP (0.212s)
[666.517025] [113/133] (359s left) gem_pwrite_snooped
[666.665335] [114/133] (359s left) i915_suspend (basic-s3-without-i915)
[666.701507] Starting subtest: basic-s3-without-i915
[670.259961] Subtest basic-s3-without-i915: SKIP (3.559s)
[671.906994] [115/133] (353s left) gem_ctx_param (get-priority-new-ctx)
[671.990449] Starting subtest: get-priority-new-ctx
[671.995836] Subtest get-priority-new-ctx: SUCCESS (0.003s)
[672.137227] [116/133] (353s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[672.232147] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[672.234373] Starting dynamic subtest: pipe-A-eDP-1
[672.507003] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.245s)
[672.519895] Starting dynamic subtest: pipe-B-eDP-1
[673.797323] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.289s)
[673.808321] Starting dynamic subtest: pipe-C-eDP-1
[675.000898] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s)
[675.011565] Starting dynamic subtest: pipe-D-eDP-1
[676.238081] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[676.240202] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.980s)
[677.370865] [117/133] (348s left) gem_pwrite (basic-exhaustion)
[677.437916] Subtest basic-exhaustion: SKIP (0.000s)
[677.495448] [118/133] (348s left) syncobj_wait (wait-for-submit-complex)
[677.549229] Starting subtest: wait-for-submit-complex
[677.610080] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[677.725857] [119/133] (348s left) kms_chamelium_audio (dp-audio)
[678.118872] Subtest dp-audio: SKIP (0.000s)
[678.964854] [120/133] (347s left) kms_getfb (getfb2-accept-nv12)
[679.061413] Starting subtest: getfb2-accept-nv12
[679.063663] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[679.190731] [121/133] (346s left) kms_force_connector_basic (force-load-detect)
[679.283411] Starting subtest: force-load-detect
[679.288141] Subtest force-load-detect: SKIP (0.000s)
[679.406665] [122/133] (346s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[679.514979] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[679.519612] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[680.631243] [123/133] (345s left) gem_exec_async (forked-writes)
[680.716266] Starting subtest: forked-writes
[680.718745] Starting dynamic subtest: rcs0
[680.744767] Dynamic subtest rcs0: SUCCESS (0.028s)
[680.755463] Starting dynamic subtest: bcs0
[680.769201] Dynamic subtest bcs0: SUCCESS (0.024s)
[680.779021] Starting dynamic subtest: vcs0
[680.792627] Dynamic subtest vcs0: SUCCESS (0.023s)
[680.802126] Starting dynamic subtest: vcs1
[680.815520] Dynamic subtest vcs1: SUCCESS (0.022s)
[680.824694] Starting dynamic subtest: vecs0
[680.838335] Dynamic subtest vecs0: SUCCESS (0.022s)
[680.847835] Starting dynamic subtest: ccs0
[680.862752] Dynamic subtest ccs0: SUCCESS (0.024s)
[680.864939] Subtest forked-writes: SUCCESS (0.147s)
[681.135684] [124/133] (345s left) kms_concurrent (multi-plane-atomic-lowres)
[681.222313] Starting subtest: multi-plane-atomic-lowres
[681.224710] Starting dynamic subtest: pipe-A-eDP-1
[681.724541] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.502s)
[681.726898] Subtest multi-plane-atomic-lowres: SUCCESS (0.503s)
[682.573086] [125/133] (343s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[682.700865] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[682.705451] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[682.873530] [126/133] (343s left) kms_frontbuffer_tracking (fbc-1p-rte)
[682.977114] Starting subtest: fbc-1p-rte
[688.492713] Subtest fbc-1p-rte: SUCCESS (5.522s)
[689.694092] [127/133] (336s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[689.801134] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[693.928074] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.130s)
[695.084549] [128/133] (331s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[695.190287] Starting subtest: primary-4-tiled-reflect-x-180
[702.175428] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.990s)
[703.455017] [129/133] (322s left) i915_module_load (reload)
[703.488891] Starting subtest: reload
[706.758091] Subtest reload: SUCCESS (3.271s)
[706.805410] [130/133] (319s left) gem_exec_store (cachelines)
[707.966404] Starting subtest: cachelines
[707.968613] Starting dynamic subtest: rcs0
[708.091518] Dynamic subtest rcs0: SUCCESS (0.126s)
[708.103515] Starting dynamic subtest: bcs0
[708.155825] Dynamic subtest bcs0: SUCCESS (0.062s)
[708.166911] Starting dynamic subtest: vcs0
[708.220480] Dynamic subtest vcs0: SUCCESS (0.063s)
[708.231767] Starting dynamic subtest: vcs1
[708.290077] Dynamic subtest vcs1: SUCCESS (0.067s)
[708.300821] Starting dynamic subtest: vecs0
[708.355481] Dynamic subtest vecs0: SUCCESS (0.063s)
[708.366078] Starting dynamic subtest: ccs0
[708.414695] Dynamic subtest ccs0: SUCCESS (0.057s)
[708.417038] Subtest cachelines: SUCCESS (0.451s)
[708.616889] [131/133] (317s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[708.704650] Starting subtest: primary-x-tiled-reflect-x-180
[715.590567] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.889s)
[716.830367] [132/133] (309s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[716.928039] Starting subtest: psr-1p-primscrn-spr-indfb-move
[724.478661] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.551s)
[724.645222] [133/133] (301s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[724.762364] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[724.766503] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[724.882348] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_frames
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_atomic
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: dmabuf_sync_file
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_plane_alpha_blend
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: kms_plane_lowres
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: prime_mmap
results: parsing output: 15/ for test: gem_ctx_param
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_atomic_interruptible
results: parsing output: 18/ for test: gem_exec_balancer
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_cursor_edge_walk
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: gem_exec_nop
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: gem_userptr_blits
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_pm_dc
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: i915_drm_fdinfo
results: parsing output: 41/ for test: gem_busy
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: kms_pm_rpm
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_color_pipeline
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_psr2_sf
results: parsing output: 50/ for test: kms_mmap_write_crc
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: gen9_exec_parse
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: gem_ctx_persistence
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: kms_async_flips
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: gem_mmap_wc
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: gem_fenced_exec_thrash
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: api_intel_bb
results: parsing output: 64/ for test: api_intel_allocator
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_chamelium_hpd
results: parsing output: 68/ for test: kms_invalid_mode
results: parsing output: 69/ for test: kms_draw_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_universal_plane
results: parsing output: 75/ for test: gem_mmap_offset
results: parsing output: 76/ for test: gem_exec_fence
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_lmem_swapping
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_create
results: parsing output: 85/ for test: kms_dp_aux_dev
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr2_sf
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: gem_spin_batch
results: parsing output: 90/ for test: kms_rotation_crc
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: perf_pmu
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: i915_pm_rc6_residency
results: parsing output: 95/ for test: sriov_basic
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: gem_lmem_swapping
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_render_copy_redux
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_plane
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: gem_pwrite_snooped
results: parsing output: 113/ for test: i915_suspend
results: parsing output: 114/ for test: gem_ctx_param
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_pwrite
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_chamelium_audio
results: parsing output: 119/ for test: kms_getfb
results: parsing output: 120/ for test: kms_force_connector_basic
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: gem_exec_async
results: parsing output: 123/ for test: kms_concurrent
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_rotation_crc
results: parsing output: 128/ for test: i915_module_load
results: parsing output: 129/ for test: gem_exec_store
results: parsing output: 130/ for test: kms_rotation_crc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.