[56.577133] Initializing watchdogs
[56.577180]   /dev/watchdog0
[56.590882] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.595123] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.597247] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.600503] [001/133] (960s left) gem_create (create-ext-placement-all)
[56.793619] Starting subtest: create-ext-placement-all
[56.795928] Subtest create-ext-placement-all: SUCCESS (0.000s)
[56.922220] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[56.993222] Starting subtest: map-fixed-invalidate-overlap
[56.997641] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[57.149827] [003/133] (960s left) gem_pipe_control_store_loop (fresh-buffer)
[57.216265] Starting subtest: fresh-buffer
[59.377902] Subtest fresh-buffer: SUCCESS (2.155s)
[59.534646] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[59.595984] Starting subtest: mmap-boundaries
[59.598361] Starting dynamic subtest: smem0
[59.873107] Dynamic subtest smem0: SUCCESS (0.278s)
[59.875605] Subtest mmap-boundaries: SUCCESS (0.279s)
[60.036205] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[60.140450] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[67.840971] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.693s)
[68.104205] [006/133] (949s left) kms_atomic (atomic-plane-damage)
[68.204227] Starting subtest: atomic-plane-damage
[68.281084] Starting dynamic subtest: pipe-A-eDP-1
[68.812115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s)
[68.814495] Subtest atomic-plane-damage: SUCCESS (0.608s)
[69.624926] [007/133] (947s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[69.719459] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[69.721937] Starting dynamic subtest: pipe-A-eDP-1
[69.780498] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[69.794275] Starting dynamic subtest: pipe-B-eDP-1
[69.839961] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.058s)
[69.848324] Starting dynamic subtest: pipe-C-eDP-1
[69.898507] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.058s)
[69.906444] Starting dynamic subtest: pipe-D-eDP-1
[69.959748] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.060s)
[69.962055] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.240s)
[72.282098] [008/133] (945s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[72.380240] Starting subtest: psr-rgb101010-draw-mmap-wc
[79.331843] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.952s)
[79.468208] [009/133] (937s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[79.532124] Starting subtest: yf-tiled-to-vebox-x-tiled
[79.536686] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[79.736512] [010/133] (937s left) syncobj_timeline (wait-all-complex)
[79.800128] Starting subtest: wait-all-complex
[80.013053] Subtest wait-all-complex: SUCCESS (0.212s)
[80.109303] [011/133] (937s left) gem_pxp (create-valid-protected-context)
[80.238086] Starting subtest: create-valid-protected-context
[80.240590] Subtest create-valid-protected-context: SUCCESS (0.002s)
[80.383352] [012/133] (937s left) gem_exec_flush (basic-wb-rw-default)
[80.447724] Starting subtest: basic-wb-rw-default
[85.895539] Subtest basic-wb-rw-default: SUCCESS (5.448s)
[86.106719] [013/133] (931s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[86.210919] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[86.213626] Starting dynamic subtest: pipe-A-eDP-1
[86.234109] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[86.244082] Starting dynamic subtest: pipe-B-eDP-1
[86.264673] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[86.271835] Starting dynamic subtest: pipe-C-eDP-1
[86.291561] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[86.298290] Starting dynamic subtest: pipe-D-eDP-1
[86.317287] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[86.319411] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[88.461860] [014/133] (929s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[88.572703] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[92.680411] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.111s)
[93.867463] [015/133] (923s left) kms_cursor_edge_walk (256x256-top-bottom)
[93.967232] Starting subtest: 256x256-top-bottom
[93.969537] Starting dynamic subtest: pipe-A-eDP-1
[97.396677] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.430s)
[97.403996] Starting dynamic subtest: pipe-D-eDP-1
[100.525559] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[100.527825] Subtest 256x256-top-bottom: SUCCESS (6.559s)
[101.344158] [016/133] (916s left) kms_force_connector_basic (force-load-detect)
[101.421805] Starting subtest: force-load-detect
[101.426287] Subtest force-load-detect: SKIP (0.000s)
[101.562697] [017/133] (916s left) syncobj_wait (invalid-signal-zero-handles)
[101.611961] Starting subtest: invalid-signal-zero-handles
[101.614206] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[101.731414] [018/133] (916s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[106.713755] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[106.716068] Starting dynamic subtest: pipe-A-eDP-1
[107.519796] Dynamic subtest pipe-A-eDP-1: SKIP (0.804s)
[107.529017] Starting dynamic subtest: pipe-B-eDP-1
[108.649630] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[108.653710] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.936s)
[109.869520] [019/133] (907s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[109.973516] Starting subtest: fbcpsr-rgb565-draw-render
[117.075530] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.103s)
[117.239351] [020/133] (900s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[117.339308] Starting subtest: primary-4-tiled-reflect-x-0
[124.556193] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.218s)
[125.778588] [021/133] (892s left) kms_setmode (clone-exclusive-crtc)
[125.848407] Starting subtest: clone-exclusive-crtc
[125.855149] Subtest clone-exclusive-crtc: SKIP (0.000s)
[125.987114] [022/133] (891s left) kms_addfb_basic (too-high)
[126.085048] Starting subtest: too-high
[126.087289] Subtest too-high: SUCCESS (0.000s)
[126.226197] [023/133] (891s left) perf_pmu (busy-accuracy-2)
[126.265978] Starting subtest: busy-accuracy-2
[126.267871] Starting dynamic subtest: rcs0
[129.306806] Dynamic subtest rcs0: SUCCESS (3.039s)
[129.317374] Starting dynamic subtest: bcs0
[132.363876] Dynamic subtest bcs0: SUCCESS (3.055s)
[132.373667] Starting dynamic subtest: vcs0
[135.413716] Dynamic subtest vcs0: SUCCESS (3.048s)
[135.424079] Starting dynamic subtest: vcs1
[138.458857] Dynamic subtest vcs1: SUCCESS (3.044s)
[138.469340] Starting dynamic subtest: vecs0
[141.505242] Dynamic subtest vecs0: SUCCESS (3.044s)
[141.515528] Starting dynamic subtest: ccs0
[144.565956] Dynamic subtest ccs0: SUCCESS (3.059s)
[144.568575] Subtest busy-accuracy-2: SUCCESS (18.298s)
[144.701391] [024/133] (873s left) kms_psr (pr-primary-mmap-gtt)
[144.796076] Starting subtest: pr-primary-mmap-gtt
[144.800415] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[144.888584] [025/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[144.984463] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[144.988579] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[145.123311] [026/133] (872s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[145.224378] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[145.228426] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[145.357054] [027/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[145.461843] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[145.464148] Starting dynamic subtest: pipe-A-default-mode
[148.199287] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s)
[148.201237] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.737s)
[149.065169] [028/133] (869s left) i915_drm_fdinfo (idle)
[149.109033] Starting subtest: idle
[149.111241] Starting dynamic subtest: rcs0
[149.716044] Dynamic subtest rcs0: SUCCESS (0.608s)
[149.726492] Starting dynamic subtest: bcs0
[150.223275] Dynamic subtest bcs0: SUCCESS (0.504s)
[150.234378] Starting dynamic subtest: vcs0
[150.729488] Dynamic subtest vcs0: SUCCESS (0.504s)
[150.740806] Starting dynamic subtest: vcs1
[151.238918] Dynamic subtest vcs1: SUCCESS (0.503s)
[151.249888] Starting dynamic subtest: vecs0
[151.740083] Dynamic subtest vecs0: SUCCESS (0.503s)
[151.751779] Starting dynamic subtest: ccs0
[152.246041] Dynamic subtest ccs0: SUCCESS (0.503s)
[152.249271] Subtest idle: SUCCESS (3.137s)
[152.346092] [029/133] (865s left) core_setmaster (master-drop-set-shared-fd)
[152.443458] Starting subtest: master-drop-set-shared-fd
[152.462125] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[152.499284] [030/133] (865s left) kms_chamelium_color (ctm-negative)
[152.623596] Subtest ctm-negative: SKIP (0.000s)
[152.669954] [031/133] (865s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[152.729929] Starting subtest: multi-wait-for-submit-available-submitted
[152.732341] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[152.864312] [032/133] (865s left) syncobj_timeline (invalid-signal-illegal-point)
[152.927057] Starting subtest: invalid-signal-illegal-point
[152.929428] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[153.054116] [033/133] (865s left) gem_mmap (bad-offset)
[153.115676] Subtest bad-offset: SKIP (0.000s)
[153.176356] [034/133] (865s left) i915_hangman (gt-error-state-capture)
[153.247437] Starting subtest: gt-error-state-capture
[153.249755] Starting dynamic subtest: rcs0
[163.892269] Dynamic subtest rcs0: SUCCESS (10.644s)
[163.903354] Starting dynamic subtest: bcs0
[175.861452] Dynamic subtest bcs0: SUCCESS (11.966s)
[175.873359] Starting dynamic subtest: vcs0
[187.830057] Dynamic subtest vcs0: SUCCESS (11.965s)
[187.840835] Starting dynamic subtest: vcs1
[198.836251] Dynamic subtest vcs1: SUCCESS (11.003s)
[198.847165] Starting dynamic subtest: vecs0
[210.804305] Dynamic subtest vecs0: SUCCESS (11.965s)
[210.815434] Starting dynamic subtest: ccs0
[220.853281] Dynamic subtest ccs0: SUCCESS (10.045s)
[220.857193] Subtest gt-error-state-capture: SUCCESS (67.603s)
[220.958088] [035/133] (797s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[221.059329] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[221.061757] Starting dynamic subtest: pipe-A-eDP-1
[221.070779] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[221.082284] Starting dynamic subtest: pipe-B-eDP-1
[221.090949] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[221.099654] Starting dynamic subtest: pipe-C-eDP-1
[221.108067] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[221.115661] Starting dynamic subtest: pipe-D-eDP-1
[221.124121] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[221.128229] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.010s)
[223.342758] [036/133] (795s left) gem_exec_whisper (basic-fds)
[223.409064] Starting subtest: basic-fds
[230.818210] Subtest basic-fds: SUCCESS (7.411s)
[231.024297] [037/133] (787s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[231.150836] Starting subtest: psr-1p-primscrn-cur-indfb-move
[238.529976] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.384s)
[238.682159] [038/133] (779s left) gem_exec_schedule (preempt-user)
[238.747408] Starting subtest: preempt-user
[238.749886] Starting dynamic subtest: rcs0
[238.761798] Dynamic subtest rcs0: SUCCESS (0.022s)
[238.772787] Starting dynamic subtest: bcs0
[238.784563] Dynamic subtest bcs0: SUCCESS (0.022s)
[238.794755] Starting dynamic subtest: vcs0
[238.806116] Dynamic subtest vcs0: SUCCESS (0.021s)
[238.815182] Starting dynamic subtest: vcs1
[238.824769] Dynamic subtest vcs1: SUCCESS (0.018s)
[238.835484] Starting dynamic subtest: vecs0
[238.845953] Dynamic subtest vecs0: SUCCESS (0.020s)
[238.854747] Starting dynamic subtest: ccs0
[238.869507] Dynamic subtest ccs0: SUCCESS (0.023s)
[238.871714] Subtest preempt-user: SUCCESS (0.131s)
[240.016607] [039/133] (778s left) kms_psr (psr2-primary-mmap-cpu)
[240.113213] Starting subtest: psr2-primary-mmap-cpu
[240.115586] Starting dynamic subtest: eDP-1
[241.813415] Dynamic subtest eDP-1: SUCCESS (1.699s)
[241.815359] Subtest psr2-primary-mmap-cpu: SUCCESS (1.700s)
[242.706936] [040/133] (775s left) gem_ctx_param (invalid-size-set)
[242.762897] Starting subtest: invalid-size-set
[242.765446] Subtest invalid-size-set: SUCCESS (0.001s)
[242.880160] [041/133] (775s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[242.976371] Starting subtest: bad-aux-stride-y-tiled-ccs
[242.978632] Starting dynamic subtest: pipe-A-eDP-1
[243.001595] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[243.012088] Starting dynamic subtest: pipe-B-eDP-1
[243.032589] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[243.040803] Starting dynamic subtest: pipe-C-eDP-1
[243.061892] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[243.070225] Starting dynamic subtest: pipe-D-eDP-1
[243.091987] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[243.096058] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[245.263907] [042/133] (773s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[245.361552] Starting subtest: blocking-absolute-wf_vblank-interruptible
[245.363875] Starting dynamic subtest: A-eDP1
[254.114849] Dynamic subtest A-eDP1: SUCCESS (8.752s)
[254.125495] Starting dynamic subtest: B-eDP1
[262.839952] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[262.850951] Starting dynamic subtest: C-eDP1
[271.547098] Dynamic subtest C-eDP1: SUCCESS (8.704s)
[271.556904] Starting dynamic subtest: D-eDP1
[280.280651] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[280.285964] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.923s)
[281.516694] [043/133] (737s left) kms_psr2_su (page_flip-nv12)
[281.579794] Subtest page_flip-NV12: SKIP (0.000s)
[281.645150] [044/133] (737s left) gem_exec_balancer (sliced)
[281.719449] Starting subtest: sliced
[281.723577] Subtest sliced: SKIP (0.000s)
[282.036459] [045/133] (736s left) kms_plane_lowres (tiling-x)
[282.130186] Starting subtest: tiling-x
[282.132284] Starting dynamic subtest: pipe-A-eDP-1
[282.136643] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[282.426103] Starting dynamic subtest: pipe-B-eDP-1
[282.430886] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[282.441230] Starting dynamic subtest: pipe-C-eDP-1
[282.445915] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[282.454301] Starting dynamic subtest: pipe-D-eDP-1
[282.458932] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[282.463088] Subtest tiling-x: SKIP (0.296s)
[283.249736] [046/133] (735s left) kms_vblank (query-busy-hang)
[283.359401] Starting subtest: query-busy-hang
[283.361351] Starting dynamic subtest: pipe-A-eDP-1
[309.649729] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.290s)
[309.668989] Starting dynamic subtest: pipe-D-eDP-1
[324.697380] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.045s)
[324.699754] Subtest query-busy-hang: SUCCESS (41.339s)
[325.517274] [047/133] (693s left) gem_exec_balancer (hang)
[325.785746] Starting subtest: hang
[327.900362] Subtest hang: SUCCESS (2.114s)
[328.047897] [048/133] (690s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[328.140144] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[328.144158] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[328.254786] [049/133] (690s left) kms_flip (bo-too-big)
[328.348818] Starting subtest: bo-too-big
[328.350950] Starting dynamic subtest: A-eDP1
[329.674688] Dynamic subtest A-eDP1: SUCCESS (1.325s)
[329.685597] Starting dynamic subtest: B-eDP1
[330.972704] Dynamic subtest B-eDP1: SUCCESS (1.296s)
[330.982689] Starting dynamic subtest: C-eDP1
[332.319161] Dynamic subtest C-eDP1: SUCCESS (1.345s)
[332.329656] Starting dynamic subtest: D-eDP1
[333.655031] Dynamic subtest D-eDP1: SUCCESS (1.335s)
[333.657492] Subtest bo-too-big: SUCCESS (5.309s)
[334.890383] [050/133] (684s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[334.957888] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[334.962521] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[335.165277] [051/133] (683s left) kms_cursor_legacy (single-bo)
[335.275310] Starting subtest: single-bo
[335.277601] Starting dynamic subtest: pipe-A
[340.654686] Dynamic subtest pipe-A: SUCCESS (5.379s)
[340.665480] Starting dynamic subtest: pipe-B
[346.037741] Dynamic subtest pipe-B: SUCCESS (5.380s)
[346.048205] Starting dynamic subtest: pipe-C
[351.418904] Dynamic subtest pipe-C: SUCCESS (5.378s)
[351.429367] Starting dynamic subtest: pipe-D
[356.800115] Dynamic subtest pipe-D: SUCCESS (5.379s)
[356.810808] Starting dynamic subtest: all-pipes
[362.188712] Dynamic subtest all-pipes: SUCCESS (5.386s)
[362.191296] Subtest single-bo: SUCCESS (26.914s)
[362.355143] [052/133] (656s left) kms_pm_rpm (basic-pci-d3-state)
[364.085390] Starting subtest: basic-pci-d3-state
[365.540666] Subtest basic-pci-d3-state: SUCCESS (1.458s)
[365.650196] [053/133] (653s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[365.752377] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[370.150858] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.401s)
[371.318922] [054/133] (647s left) kms_pm_rpm (legacy-planes)
[373.059435] Starting subtest: legacy-planes
[373.062466] Starting dynamic subtest: plane-63
[381.553796] Dynamic subtest plane-63: SUCCESS (8.492s)
[381.564433] Starting dynamic subtest: plane-93
[389.840321] Dynamic subtest plane-93: SUCCESS (8.285s)
[389.851543] Starting dynamic subtest: plane-123
[398.122730] Dynamic subtest plane-123: SUCCESS (8.279s)
[398.134788] Starting dynamic subtest: plane-133
[406.409873] Dynamic subtest plane-133: SUCCESS (8.285s)
[406.412413] Subtest legacy-planes: SUCCESS (33.352s)
[406.811395] [055/133] (612s left) prime_self_import (basic-with_one_bo)
[406.857063] Starting subtest: basic-with_one_bo
[406.884138] Subtest basic-with_one_bo: SUCCESS (0.028s)
[407.040845] [056/133] (612s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[407.137762] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[407.142116] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[407.282556] [057/133] (611s left) kms_flip (modeset-vs-vblank-race)
[407.366162] Starting subtest: modeset-vs-vblank-race
[407.368402] Starting dynamic subtest: A-eDP1
[412.100949] Dynamic subtest A-eDP1: SUCCESS (4.734s)
[412.112076] Starting dynamic subtest: B-eDP1
[416.833325] Dynamic subtest B-eDP1: SUCCESS (4.730s)
[416.848971] Starting dynamic subtest: C-eDP1
[421.544346] Dynamic subtest C-eDP1: SUCCESS (4.708s)
[421.554224] Starting dynamic subtest: D-eDP1
[426.170609] Dynamic subtest D-eDP1: SUCCESS (4.625s)
[426.175902] Subtest modeset-vs-vblank-race: SUCCESS (18.810s)
[427.450367] [058/133] (591s left) gem_lmem_swapping (heavy-verify-random-ccs)
[427.488978] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[427.536464] [059/133] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[427.646774] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[427.651168] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[427.772853] [060/133] (591s left) kms_chamelium_color (gamma)
[427.876331] Subtest gamma: SKIP (0.000s)
[427.925348] [061/133] (591s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[428.042267] Starting subtest: cursorB-vs-flipA-varying-size
[428.046582] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[428.209032] [062/133] (591s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[428.311512] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[432.743540] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.435s)
[433.955807] [063/133] (585s left) dumb_buffer (map-valid)
[434.008993] Starting subtest: map-valid
[434.011180] Subtest map-valid: SUCCESS (0.000s)
[434.131401] [064/133] (585s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[434.228147] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[434.230349] Starting dynamic subtest: pipe-A-default-mode
[434.551925] Dynamic subtest pipe-A-default-mode: SKIP (0.323s)
[434.556408] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.325s)
[435.375649] [065/133] (584s left) perf (i915-ref-count)
[435.467502] Starting subtest: i915-ref-count
[435.526904] Subtest i915-ref-count: SUCCESS (0.058s)
[435.582853] [066/133] (584s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[435.686101] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[435.690175] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[435.827600] [067/133] (583s left) gem_softpin (noreloc-interruptible)
[435.885792] Starting subtest: noreloc-interruptible
[441.310295] Subtest noreloc-interruptible: SUCCESS (5.423s)
[441.474362] [068/133] (578s left) kms_psr (fbc-psr2-primary-render)
[441.578946] Starting subtest: fbc-psr2-primary-render
[441.581289] Starting dynamic subtest: eDP-1
[441.585569] Dynamic subtest eDP-1: SKIP (0.000s)
[441.589733] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[441.677132] [069/133] (578s left) kms_lease (atomic-implicit-crtc)
[441.778227] Starting subtest: atomic-implicit-crtc
[441.780532] Starting dynamic subtest: pipe-A-eDP-1
[441.791661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[441.804947] Starting dynamic subtest: pipe-B-eDP-1
[441.816524] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[441.826571] Starting dynamic subtest: pipe-C-eDP-1
[441.837082] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[441.845278] Starting dynamic subtest: pipe-D-eDP-1
[441.855900] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[441.858069] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[441.963097] [070/133] (577s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[442.080374] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[442.458498] Starting dynamic subtest: pipe-A-eDP-1
[445.221699] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.763s)
[445.594201] Starting dynamic subtest: pipe-B-eDP-1
[448.359544] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.771s)
[448.719483] Starting dynamic subtest: pipe-C-eDP-1
[451.494484] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.780s)
[451.864557] Starting dynamic subtest: pipe-D-eDP-1
[454.622364] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.763s)
[454.625064] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.543s)
[455.840044] [071/133] (563s left) gem_exec_reloc (basic-wc-read-active)
[455.905500] Subtest basic-wc-read-active: SKIP (0.000s)
[455.990059] [072/133] (563s left) gem_readwrite (new-obj)
[456.038615] Subtest new-obj: SKIP (0.000s)
[456.145964] [073/133] (563s left) gem_mmap_gtt (basic-short)
[456.203819] Subtest basic-short: SKIP (0.000s)
[456.270259] [074/133] (563s left) kms_plane_multiple (tiling-yf)
[456.355785] Starting subtest: tiling-yf
[456.359745] Subtest tiling-yf: SKIP (0.000s)
[456.449532] [075/133] (563s left) kms_content_protection (dp-mst-type-0-hdcp14)
[456.597797] Starting subtest: dp-mst-type-0-hdcp14
[456.602414] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[456.753670] [076/133] (563s left) gem_ctx_shared (q-in-order)
[456.805725] Starting subtest: Q-in-order
[456.807854] Starting dynamic subtest: rcs0
[456.959471] Dynamic subtest rcs0: SUCCESS (0.155s)
[456.975762] Starting dynamic subtest: vcs0
[457.033057] Dynamic subtest vcs0: SUCCESS (0.073s)
[457.049576] Starting dynamic subtest: vcs1
[457.107926] Dynamic subtest vcs1: SUCCESS (0.074s)
[457.123457] Starting dynamic subtest: vecs0
[457.182355] Dynamic subtest vecs0: SUCCESS (0.073s)
[457.197323] Starting dynamic subtest: ccs0
[457.268106] Dynamic subtest ccs0: SUCCESS (0.085s)
[457.270270] Subtest Q-in-order: SUCCESS (0.465s)
[459.031107] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[459.034427] [077/133] (561s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[459.095069] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[459.202282] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[459.307260] [078/133] (560s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[459.408322] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[466.021957] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.614s)
[466.190386] [079/133] (553s left) kms_big_fb (linear-8bpp-rotate-270)
[466.303093] Starting subtest: linear-8bpp-rotate-270
[466.322814] Subtest linear-8bpp-rotate-270: SKIP (0.019s)
[466.460200] [080/133] (553s left) api_intel_allocator (standalone)
[466.522869] Starting subtest: standalone
[466.536942] Subtest standalone: SUCCESS (0.015s)
[466.696242] [081/133] (553s left) core_auth (getclient-master-drop)
[466.739724] Starting subtest: getclient-master-drop
[466.761078] Subtest getclient-master-drop: SUCCESS (0.024s)
[466.878182] [082/133] (553s left) kms_psr (fbc-psr2-basic)
[466.973098] Starting subtest: fbc-psr2-basic
[466.975386] Starting dynamic subtest: eDP-1
[466.979774] Dynamic subtest eDP-1: SKIP (0.000s)
[466.984218] Subtest fbc-psr2-basic: SKIP (0.001s)
[467.067794] [083/133] (553s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[467.205893] Starting subtest: cursor-rapid-movement-32x32
[467.251408] Subtest cursor-rapid-movement-32x32: SKIP (0.041s)
[467.567873] [084/133] (552s left) gem_exec_schedule (noreorder-priority)
[467.752453] Starting subtest: noreorder-priority
[467.755028] Starting dynamic subtest: rcs0
[468.901884] Dynamic subtest rcs0: SUCCESS (1.151s)
[468.915837] Starting dynamic subtest: vcs0
[470.941366] Dynamic subtest vcs0: SUCCESS (2.036s)
[470.952887] Starting dynamic subtest: vcs1
[472.959118] Dynamic subtest vcs1: SUCCESS (2.015s)
[472.970572] Starting dynamic subtest: vecs0
[474.919237] Dynamic subtest vecs0: SUCCESS (1.957s)
[474.931161] Starting dynamic subtest: ccs0
[476.082562] Dynamic subtest ccs0: SUCCESS (1.162s)
[476.085469] Subtest noreorder-priority: SUCCESS (8.332s)
[476.292929] [085/133] (544s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[476.403050] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[476.405323] Starting dynamic subtest: pipe-A-eDP-1
[476.429486] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[476.439632] Starting dynamic subtest: pipe-B-eDP-1
[476.462698] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[476.470969] Starting dynamic subtest: pipe-C-eDP-1
[476.493234] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[476.501687] Starting dynamic subtest: pipe-D-eDP-1
[476.525285] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[476.529324] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.014s)
[478.734630] [086/133] (541s left) core_auth (many-magics)
[478.784898] Starting subtest: many-magics
[479.666510] Subtest many-magics: SUCCESS (0.883s)
[479.878043] [087/133] (540s left) i915_suspend (fence-restore-tiled2untiled)
[479.932315] Starting subtest: fence-restore-tiled2untiled
[479.936431] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[480.062961] [088/133] (540s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[480.150251] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[480.152359] Starting dynamic subtest: pipe-A
[480.170031] Dynamic subtest pipe-A: SKIP (0.017s)
[480.180840] Starting dynamic subtest: pipe-B
[480.200676] Dynamic subtest pipe-B: SKIP (0.030s)
[480.209212] Starting dynamic subtest: pipe-C
[480.230516] Dynamic subtest pipe-C: SKIP (0.029s)
[480.240347] Starting dynamic subtest: pipe-D
[480.261278] Dynamic subtest pipe-D: SKIP (0.029s)
[480.265639] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.108s)
[480.391343] [089/133] (540s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[480.493762] Starting subtest: y-tiled-64bpp-rotate-0
[480.497859] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[480.632145] [090/133] (539s left) gem_ctx_persistence (saturated-hostile)
[480.695235] Starting subtest: saturated-hostile
[480.697677] Starting dynamic subtest: rcs0
[481.558927] Dynamic subtest rcs0: SUCCESS (0.864s)
[481.570240] Starting dynamic subtest: bcs0
[482.359154] Dynamic subtest bcs0: SUCCESS (0.794s)
[482.367884] Starting dynamic subtest: vcs0
[483.167065] Dynamic subtest vcs0: SUCCESS (0.809s)
[483.176783] Starting dynamic subtest: vcs1
[483.988082] Dynamic subtest vcs1: SUCCESS (0.819s)
[484.000017] Starting dynamic subtest: vecs0
[484.803065] Dynamic subtest vecs0: SUCCESS (0.812s)
[484.819199] Starting dynamic subtest: ccs0
[485.671212] Dynamic subtest ccs0: SUCCESS (0.866s)
[485.673621] Subtest saturated-hostile: SUCCESS (4.978s)
[485.774170] [091/133] (534s left) kms_prop_blob (invalid-get-prop)
[485.834851] Starting subtest: invalid-get-prop
[485.837191] Subtest invalid-get-prop: SUCCESS (0.000s)
[485.976079] [092/133] (534s left) gem_mmap_gtt (basic-write)
[486.044210] Subtest basic-write: SKIP (0.000s)
[486.114285] [093/133] (534s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[486.240380] Starting subtest: cursorA-vs-flipA-varying-size
[497.393701] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.151s)
[498.268189] [094/133] (522s left) gem_linear_blits (interruptible)
[498.629435] Starting subtest: interruptible
[503.001545] Subtest interruptible: SUCCESS (4.371s)
[503.193960] [095/133] (517s left) gem_exec_params (sol-reset-invalid)
[503.295055] Starting subtest: sol-reset-invalid
[503.300630] Subtest sol-reset-invalid: SUCCESS (0.004s)
[504.997459] [096/133] (515s left) kms_color_pipeline (plane-lut1d)
[505.102818] Starting subtest: plane-lut1d
[505.119435] Starting dynamic subtest: pipe-A-eDP-1
[505.827516] Dynamic subtest pipe-A-eDP-1: FAIL (0.322s)
[506.524222] Starting dynamic subtest: pipe-B-eDP-1
[507.399886] Dynamic subtest pipe-B-eDP-1: FAIL (0.357s)
[507.962931] Starting dynamic subtest: pipe-C-eDP-1
[508.773041] Dynamic subtest pipe-C-eDP-1: FAIL (0.237s)
[509.285784] Starting dynamic subtest: pipe-D-eDP-1
[510.148933] Dynamic subtest pipe-D-eDP-1: FAIL (0.279s)
[510.151287] Subtest plane-lut1d: FAIL (4.757s)
[510.691801] [097/133] (510s left) gem_wait (busy)
[510.759383] Starting subtest: busy
[510.761429] Starting dynamic subtest: all-engines
[511.893813] Dynamic subtest all-engines: SUCCESS (1.135s)
[511.906660] Starting dynamic subtest: rcs0
[512.438667] Dynamic subtest rcs0: SUCCESS (0.544s)
[512.450980] Starting dynamic subtest: bcs0
[512.978911] Dynamic subtest bcs0: SUCCESS (0.538s)
[512.990472] Starting dynamic subtest: vcs0
[514.901504] Dynamic subtest vcs0: SUCCESS (1.920s)
[514.913095] Starting dynamic subtest: vcs1
[516.885052] Dynamic subtest vcs1: SUCCESS (1.981s)
[516.897326] Starting dynamic subtest: vecs0
[518.933290] Dynamic subtest vecs0: SUCCESS (2.045s)
[518.946028] Starting dynamic subtest: ccs0
[519.475262] Dynamic subtest ccs0: SUCCESS (0.541s)
[519.477647] Subtest busy: SUCCESS (8.719s)
[519.703270] [098/133] (501s left) sriov_basic (enable-vfs-autoprobe-on)
[519.766034] Starting subtest: enable-vfs-autoprobe-on
[519.767983] Starting dynamic subtest: numvfs-1
[519.839453] Dynamic subtest numvfs-1: FAIL (0.006s)
[519.850767] Starting dynamic subtest: numvfs-2
[519.923495] Dynamic subtest numvfs-2: FAIL (0.004s)
[519.933870] Starting dynamic subtest: numvfs-3
[520.005967] Dynamic subtest numvfs-3: FAIL (0.004s)
[520.015476] Starting dynamic subtest: numvfs-4
[520.083691] Dynamic subtest numvfs-4: FAIL (0.003s)
[520.093601] Starting dynamic subtest: numvfs-5
[520.163842] Dynamic subtest numvfs-5: FAIL (0.005s)
[520.172564] Starting dynamic subtest: numvfs-6
[520.241074] Dynamic subtest numvfs-6: FAIL (0.003s)
[520.250610] Starting dynamic subtest: numvfs-7
[520.320643] Dynamic subtest numvfs-7: FAIL (0.003s)
[520.330225] Starting dynamic subtest: numvfs-random
[520.403270] Dynamic subtest numvfs-random: FAIL (0.003s)
[520.413418] Starting dynamic subtest: numvfs-all
[520.485951] Dynamic subtest numvfs-all: FAIL (0.493s)
[520.488344] Subtest enable-vfs-autoprobe-on: FAIL (0.532s)
[520.528473] [099/133] (500s left) kms_chamelium_frames (vga-frame-dump)
[520.929852] Subtest vga-frame-dump: SKIP (0.000s)
[521.777450] [100/133] (499s left) gem_eio (throttle)
[521.988097] Starting subtest: throttle
[522.246020] Subtest throttle: SUCCESS (0.256s)
[522.387160] [101/133] (498s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[522.486607] Starting subtest: psr-abgr161616f-draw-mmap-wc
[522.490712] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[522.623924] [102/133] (498s left) gem_softpin (allocator-nopin)
[522.695253] Starting subtest: allocator-nopin
[522.786368] Subtest allocator-nopin: SUCCESS (0.091s)
[522.930199] [103/133] (498s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[523.023254] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[523.703498] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[523.910983] [104/133] (497s left) kms_flip (busy-flip)
[524.002245] Starting subtest: busy-flip
[524.004597] Starting dynamic subtest: A-eDP1
[525.708648] Dynamic subtest A-eDP1: SUCCESS (1.706s)
[525.720249] Starting dynamic subtest: B-eDP1
[527.357288] Dynamic subtest B-eDP1: SUCCESS (1.647s)
[527.368732] Starting dynamic subtest: C-eDP1
[528.992086] Dynamic subtest C-eDP1: SUCCESS (1.633s)
[529.002674] Starting dynamic subtest: D-eDP1
[530.631260] Dynamic subtest D-eDP1: SUCCESS (1.638s)
[530.636530] Subtest busy-flip: SUCCESS (6.634s)
[531.927084] [105/133] (489s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[532.032907] Starting subtest: x-tiled-16bpp-rotate-270
[532.052685] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[532.222416] [106/133] (489s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[532.326444] Starting subtest: fbcpsr-abgr161616f-draw-render
[532.330472] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[532.446520] [107/133] (488s left) kms_getfb (getfb2-accept-nv12)
[532.538735] Starting subtest: getfb2-accept-nv12
[532.540991] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[532.673448] [108/133] (488s left) gem_ctx_exec (basic-nohangcheck)
[532.740532] Starting subtest: basic-nohangcheck
[533.006961] Subtest basic-nohangcheck: SUCCESS (0.266s)
[533.167456] [109/133] (488s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[533.290528] Starting subtest: short-flip-before-cursor-atomic-transitions
[534.231960] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.943s)
[535.048441] [110/133] (486s left) kms_cursor_crc (cursor-offscreen-256x256)
[535.278606] Starting subtest: cursor-offscreen-256x256
[535.283824] Starting dynamic subtest: pipe-A-eDP-1
[537.207297] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.918s)
[537.231390] Starting dynamic subtest: pipe-D-eDP-1
[539.812906] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.587s)
[539.815187] Subtest cursor-offscreen-256x256: SUCCESS (4.531s)
[540.704549] [111/133] (480s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[540.813821] Starting subtest: 4-tiled-8bpp-rotate-0
[542.026175] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.212s)
[542.180105] [112/133] (479s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[542.246265] Subtest writes-after-reads: SKIP (0.000s)
[542.317633] [113/133] (479s left) kms_frontbuffer_tracking (psr-slowdraw)
[542.419343] Starting subtest: psr-slowdraw
[567.578579] Subtest psr-slowdraw: SUCCESS (25.158s)
[567.751627] [114/133] (453s left) i915_pm_rc6_residency (rc6-idle)
[567.812354] Starting subtest: rc6-idle
[567.846462] Starting dynamic subtest: gt0-rcs0
[592.054544] Dynamic subtest gt0-rcs0: SUCCESS (24.206s)
[592.066103] Starting dynamic subtest: gt0-bcs0
[616.460052] Dynamic subtest gt0-bcs0: SUCCESS (24.402s)
[616.469083] Starting dynamic subtest: gt0-ccs0
[640.746752] Dynamic subtest gt0-ccs0: SUCCESS (24.284s)
[640.757794] Starting dynamic subtest: gt1-vcs0
[646.920934] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[646.932686] Starting dynamic subtest: gt1-vecs0
[653.092214] Dynamic subtest gt1-vecs0: SUCCESS (6.168s)
[653.094812] Subtest rc6-idle: SUCCESS (85.281s)
[653.197531] [115/133] (368s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[653.294077] Starting subtest: fbc-modesetfrombusy
[657.055818] Subtest fbc-modesetfrombusy: SUCCESS (3.764s)
[658.278692] [116/133] (363s left) kms_psr (psr-cursor-render)
[658.376845] Starting subtest: psr-cursor-render
[658.379104] Starting dynamic subtest: eDP-1
[660.101072] Dynamic subtest eDP-1: SUCCESS (1.724s)
[660.103447] Subtest psr-cursor-render: SUCCESS (1.726s)
[660.993142] [117/133] (360s left) gem_exec_parallel (engines)
[661.062727] Starting subtest: engines
[661.064976] Starting dynamic subtest: basic
[662.869483] Dynamic subtest basic: SUCCESS (1.805s)
[662.881574] Starting dynamic subtest: contexts
[667.349245] Dynamic subtest contexts: SUCCESS (4.477s)
[667.365821] Starting dynamic subtest: fds
[672.949494] Dynamic subtest fds: SUCCESS (5.598s)
[672.960670] Starting dynamic subtest: userptr
[674.920652] Dynamic subtest userptr: SUCCESS (1.968s)
[674.923208] Subtest engines: SUCCESS (13.857s)
[675.138948] [118/133] (346s left) prime_busy (after)
[675.204748] Starting subtest: after
[675.210069] Starting dynamic subtest: rcs0
[675.263622] Dynamic subtest rcs0: SUCCESS (0.055s)
[675.274704] Starting dynamic subtest: bcs0
[675.345020] Dynamic subtest bcs0: SUCCESS (0.080s)
[675.355569] Starting dynamic subtest: vcs0
[675.387172] Dynamic subtest vcs0: SUCCESS (0.041s)
[675.396391] Starting dynamic subtest: vcs1
[675.429597] Dynamic subtest vcs1: SUCCESS (0.042s)
[675.439021] Starting dynamic subtest: vecs0
[675.471639] Dynamic subtest vecs0: SUCCESS (0.041s)
[675.482775] Starting dynamic subtest: ccs0
[675.512813] Dynamic subtest ccs0: SUCCESS (0.038s)
[675.620311] Subtest after: SUCCESS (0.414s)
[675.720921] [119/133] (346s left) gem_partial_pwrite_pread (write-display)
[675.786388] Subtest write-display: SKIP (0.000s)
[675.872562] [120/133] (346s left) gem_tiled_blits (basic)
[675.931257] Subtest basic: SKIP (0.000s)
[675.987216] [121/133] (345s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[676.089441] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[684.530464] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.443s)
[684.681113] [122/133] (337s left) sysfs_defaults (readonly)
[684.748022] Starting subtest: readonly
[684.750283] Starting dynamic subtest: vecs0
[684.752582] Dynamic subtest vecs0: SUCCESS (0.000s)
[684.763098] Starting dynamic subtest: ccs0
[684.764938] Dynamic subtest ccs0: SUCCESS (0.000s)
[684.773636] Starting dynamic subtest: vcs0
[684.775521] Dynamic subtest vcs0: SUCCESS (0.000s)
[684.783990] Starting dynamic subtest: bcs0
[684.785897] Dynamic subtest bcs0: SUCCESS (0.000s)
[684.794271] Starting dynamic subtest: rcs0
[684.796116] Dynamic subtest rcs0: SUCCESS (0.000s)
[684.804438] Starting dynamic subtest: vcs1
[684.806748] Dynamic subtest vcs1: SUCCESS (0.000s)
[684.808938] Subtest readonly: SUCCESS (0.005s)
[684.888734] [123/133] (337s left) kms_dsc (dsc-with-formats)
[684.992395] Starting subtest: dsc-with-formats
[685.032385] Subtest dsc-with-formats: SKIP (0.001s)
[685.093549] [124/133] (337s left) prime_mmap (test_reprime)
[685.151621] Starting subtest: test_reprime
[685.153815] Starting dynamic subtest: test_reprime-smem
[685.178767] Dynamic subtest test_reprime-smem: SUCCESS (0.029s)
[685.181248] Subtest test_reprime: SUCCESS (0.030s)
[685.313858] [125/133] (336s left) gem_exec_params (rsvd2-dirt)
[685.361211] Starting subtest: rsvd2-dirt
[685.365730] Subtest rsvd2-dirt: SKIP (0.000s)
[685.488558] [126/133] (336s left) kms_lease (lessee-list)
[685.589233] Starting subtest: lessee-list
[685.591196] Starting dynamic subtest: pipe-A-eDP-1
[685.593066] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[685.602562] Starting dynamic subtest: pipe-B-eDP-1
[685.604361] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[685.613447] Starting dynamic subtest: pipe-C-eDP-1
[685.615236] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[685.624395] Starting dynamic subtest: pipe-D-eDP-1
[685.626360] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[685.628292] Subtest lessee-list: SUCCESS (0.008s)
[685.736236] [127/133] (336s left) kms_vrr (flip-dpms)
[685.833519] Starting subtest: flip-dpms
[685.838687] Subtest flip-dpms: SKIP (0.000s)
[685.927233] [128/133] (336s left) kms_frontbuffer_tracking (fbc-1p-rte)
[686.033128] Starting subtest: fbc-1p-rte
[691.481581] Subtest fbc-1p-rte: SUCCESS (5.451s)
[692.712611] [129/133] (329s left) gen9_exec_parse (batch-zero-length)
[692.788666] Subtest batch-zero-length: SKIP (0.000s)
[692.872281] [130/133] (329s left) prime_mmap (test_aperture_limit)
[692.933993] Starting subtest: test_aperture_limit
[692.936615] Starting dynamic subtest: test_aperture_limit-smem
[692.944232] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[692.948227] Subtest test_aperture_limit: SKIP (0.008s)
[693.058302] [131/133] (329s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[693.158516] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[693.162884] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[693.294879] [132/133] (329s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[693.397457] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[693.401504] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[693.586912] [133/133] (328s left) gem_exec_fence (long-history)
[694.231293] Starting subtest: long-history
[701.654279] Subtest long-history: SUCCESS (7.423s)
[702.467319] Closing watchdogs
results: parsing output: 0/ for test: gem_create
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_pipe_control_store_loop
results: parsing output: 3/ for test: gem_mmap_offset
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_atomic
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: gem_exec_flush
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_cursor_edge_walk
results: parsing output: 15/ for test: kms_force_connector_basic
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_rotation_crc
results: parsing output: 20/ for test: kms_setmode
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: core_setmaster
results: parsing output: 29/ for test: kms_chamelium_color
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: gem_mmap
results: parsing output: 33/ for test: i915_hangman
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_ctx_param
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_psr2_su
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: kms_plane_lowres
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_render_copy
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_pm_rpm
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: prime_self_import
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_chamelium_color
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: dumb_buffer
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_async_flips
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: gem_readwrite
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_plane_multiple
results: parsing output: 74/ for test: kms_content_protection
results: parsing output: 75/ for test: gem_ctx_shared
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: api_intel_allocator
results: parsing output: 80/ for test: core_auth
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: core_auth
results: parsing output: 86/ for test: i915_suspend
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_prop_blob
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: gem_linear_blits
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_color_pipeline
results: parsing output: 96/ for test: gem_wait
results: parsing output: 97/ for test: sriov_basic
results: parsing output: 98/ for test: kms_chamelium_frames
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_ctx_exec
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: i915_pm_rc6_residency
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: gem_exec_parallel
results: parsing output: 117/ for test: prime_busy
results: parsing output: 118/ for test: gem_partial_pwrite_pread
results: parsing output: 119/ for test: gem_tiled_blits
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sysfs_defaults
results: parsing output: 122/ for test: kms_dsc
results: parsing output: 123/ for test: prime_mmap
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: kms_vrr
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gen9_exec_parse
results: parsing output: 129/ for test: prime_mmap
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_fence
Done.