[151.531377] Initializing watchdogs
[151.531419]   /dev/watchdog0
[151.544763] [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]
[151.548813] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[151.550956] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[151.554335] [001/133] (960s left) gem_create (create-ext-placement-all)
[151.742706] Starting subtest: create-ext-placement-all
[151.745524] Subtest create-ext-placement-all: SUCCESS (0.000s)
[151.878220] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[151.961555] Starting subtest: map-fixed-invalidate-overlap
[151.966212] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[152.109777] [003/133] (960s left) gem_pipe_control_store_loop (fresh-buffer)
[152.170714] Starting subtest: fresh-buffer
[154.327584] Subtest fresh-buffer: SUCCESS (2.157s)
[154.488749] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[154.548933] Starting subtest: mmap-boundaries
[154.551029] Starting dynamic subtest: smem0
[154.826071] Dynamic subtest smem0: SUCCESS (0.279s)
[154.828661] Subtest mmap-boundaries: SUCCESS (0.280s)
[154.984911] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[155.102129] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[162.375990] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.276s)
[162.556981] [006/133] (949s left) kms_atomic (atomic-plane-damage)
[162.678083] Starting subtest: atomic-plane-damage
[162.753183] Starting dynamic subtest: pipe-A-eDP-1
[163.278365] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.524s)
[163.280667] Subtest atomic-plane-damage: SUCCESS (0.602s)
[164.108087] [007/133] (948s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[164.214044] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[164.216339] Starting dynamic subtest: pipe-A-eDP-1
[164.272601] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.059s)
[164.280588] Starting dynamic subtest: pipe-B-eDP-1
[164.330783] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.058s)
[164.339823] Starting dynamic subtest: pipe-C-eDP-1
[164.390422] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.059s)
[164.397740] Starting dynamic subtest: pipe-D-eDP-1
[164.449219] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.058s)
[164.451528] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.238s)
[166.678155] [008/133] (945s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[166.782700] Starting subtest: psr-rgb101010-draw-mmap-wc
[173.749099] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.968s)
[173.913657] [009/133] (938s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[173.987451] Starting subtest: yf-tiled-to-vebox-x-tiled
[173.991764] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[174.191195] [010/133] (938s left) syncobj_timeline (wait-all-complex)
[174.254670] Starting subtest: wait-all-complex
[174.469026] Subtest wait-all-complex: SUCCESS (0.214s)
[174.569030] [011/133] (937s left) gem_pxp (create-valid-protected-context)
[174.703902] Starting subtest: create-valid-protected-context
[174.706672] Subtest create-valid-protected-context: SUCCESS (0.002s)
[174.855714] [012/133] (937s left) gem_exec_flush (basic-wb-rw-default)
[174.921817] Starting subtest: basic-wb-rw-default
[180.405460] Subtest basic-wb-rw-default: SUCCESS (5.485s)
[180.612249] [013/133] (931s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[180.712723] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[180.715052] Starting dynamic subtest: pipe-A-eDP-1
[180.735826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[180.745368] Starting dynamic subtest: pipe-B-eDP-1
[180.765071] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[180.771412] Starting dynamic subtest: pipe-C-eDP-1
[180.791796] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[180.798248] Starting dynamic subtest: pipe-D-eDP-1
[180.817414] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[180.819313] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[182.884426] [014/133] (929s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[182.982903] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[187.094765] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.115s)
[188.284940] [015/133] (924s left) kms_cursor_edge_walk (256x256-top-bottom)
[188.369377] Starting subtest: 256x256-top-bottom
[188.371774] Starting dynamic subtest: pipe-A-eDP-1
[191.805212] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.435s)
[191.814106] Starting dynamic subtest: pipe-D-eDP-1
[194.930210] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[194.932463] Subtest 256x256-top-bottom: SUCCESS (6.561s)
[195.762854] [016/133] (916s left) kms_force_connector_basic (force-load-detect)
[195.847516] Starting subtest: force-load-detect
[195.852301] Subtest force-load-detect: SKIP (0.000s)
[196.023374] [017/133] (916s left) syncobj_wait (invalid-signal-zero-handles)
[196.080562] Starting subtest: invalid-signal-zero-handles
[196.082588] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[196.209465] [018/133] (916s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[201.235369] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[201.237731] Starting dynamic subtest: pipe-A-eDP-1
[202.016042] Dynamic subtest pipe-A-eDP-1: SKIP (0.776s)
[202.024738] Starting dynamic subtest: pipe-B-eDP-1
[203.151374] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[203.155621] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.914s)
[204.366509] [019/133] (908s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[204.474114] Starting subtest: fbcpsr-rgb565-draw-render
[211.646122] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.174s)
[211.814672] [020/133] (900s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[211.923098] Starting subtest: primary-4-tiled-reflect-x-0
[218.901790] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.980s)
[220.199525] [021/133] (892s left) kms_setmode (clone-exclusive-crtc)
[220.265074] Starting subtest: clone-exclusive-crtc
[220.271696] Subtest clone-exclusive-crtc: SKIP (0.000s)
[220.412341] [022/133] (892s left) kms_addfb_basic (too-high)
[220.529628] Starting subtest: too-high
[220.531480] Subtest too-high: SUCCESS (0.000s)
[220.651355] [023/133] (892s left) perf_pmu (busy-accuracy-2)
[220.693967] Starting subtest: busy-accuracy-2
[220.695793] Starting dynamic subtest: rcs0
[223.735485] Dynamic subtest rcs0: SUCCESS (3.040s)
[223.745478] Starting dynamic subtest: bcs0
[226.793697] Dynamic subtest bcs0: SUCCESS (3.057s)
[226.803932] Starting dynamic subtest: vcs0
[229.838913] Dynamic subtest vcs0: SUCCESS (3.043s)
[229.849593] Starting dynamic subtest: vcs1
[232.886711] Dynamic subtest vcs1: SUCCESS (3.046s)
[232.897363] Starting dynamic subtest: vecs0
[235.930127] Dynamic subtest vecs0: SUCCESS (3.041s)
[235.939057] Starting dynamic subtest: ccs0
[238.994697] Dynamic subtest ccs0: SUCCESS (3.063s)
[238.997156] Subtest busy-accuracy-2: SUCCESS (18.300s)
[239.132286] [024/133] (873s left) kms_psr (pr-primary-mmap-gtt)
[239.240865] Starting subtest: pr-primary-mmap-gtt
[239.245267] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[239.333439] [025/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[239.433672] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[239.437816] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[239.570993] [026/133] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[239.660479] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[239.664900] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[239.779270] [027/133] (873s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[239.874800] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[239.877083] Starting dynamic subtest: pipe-A-default-mode
[242.611071] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s)
[242.613517] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.737s)
[243.484178] [028/133] (869s left) i915_drm_fdinfo (idle)
[243.529394] Starting subtest: idle
[243.531909] Starting dynamic subtest: rcs0
[244.106539] Dynamic subtest rcs0: SUCCESS (0.577s)
[244.115543] Starting dynamic subtest: bcs0
[244.613304] Dynamic subtest bcs0: SUCCESS (0.503s)
[244.621765] Starting dynamic subtest: vcs0
[245.118227] Dynamic subtest vcs0: SUCCESS (0.503s)
[245.127260] Starting dynamic subtest: vcs1
[245.623222] Dynamic subtest vcs1: SUCCESS (0.503s)
[245.631774] Starting dynamic subtest: vecs0
[246.133063] Dynamic subtest vecs0: SUCCESS (0.503s)
[246.142896] Starting dynamic subtest: ccs0
[246.636082] Dynamic subtest ccs0: SUCCESS (0.504s)
[246.639251] Subtest idle: SUCCESS (3.107s)
[246.733498] [029/133] (866s left) core_setmaster (master-drop-set-shared-fd)
[246.829430] Starting subtest: master-drop-set-shared-fd
[246.840445] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[246.874087] [030/133] (866s left) kms_chamelium_color (ctm-negative)
[246.976294] Subtest ctm-negative: SKIP (0.000s)
[247.018693] [031/133] (866s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[247.075377] Starting subtest: multi-wait-for-submit-available-submitted
[247.077760] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[247.189318] [032/133] (866s left) syncobj_timeline (invalid-signal-illegal-point)
[247.254947] Starting subtest: invalid-signal-illegal-point
[247.257483] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[247.394727] [033/133] (865s left) gem_mmap (bad-offset)
[247.460127] Subtest bad-offset: SKIP (0.000s)
[247.530751] [034/133] (865s left) i915_hangman (gt-error-state-capture)
[247.597460] Starting subtest: gt-error-state-capture
[247.599636] Starting dynamic subtest: rcs0
[258.868612] Dynamic subtest rcs0: SUCCESS (11.270s)
[258.880967] Starting dynamic subtest: bcs0
[270.900832] Dynamic subtest bcs0: SUCCESS (12.029s)
[270.911637] Starting dynamic subtest: vcs0
[282.802947] Dynamic subtest vcs0: SUCCESS (11.899s)
[282.814024] Starting dynamic subtest: vcs1
[293.811397] Dynamic subtest vcs1: SUCCESS (11.005s)
[293.822553] Starting dynamic subtest: vecs0
[303.857901] Dynamic subtest vecs0: SUCCESS (10.044s)
[303.868723] Starting dynamic subtest: ccs0
[315.892040] Dynamic subtest ccs0: SUCCESS (12.030s)
[315.894932] Subtest gt-error-state-capture: SUCCESS (68.291s)
[315.997819] [035/133] (797s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[316.106992] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[316.109334] Starting dynamic subtest: pipe-A-eDP-1
[316.118531] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[316.128384] Starting dynamic subtest: pipe-B-eDP-1
[316.137112] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[316.145215] Starting dynamic subtest: pipe-C-eDP-1
[316.153547] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[316.161362] Starting dynamic subtest: pipe-D-eDP-1
[316.169867] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[316.174066] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[318.343818] [036/133] (795s left) gem_exec_whisper (basic-fds)
[318.424467] Starting subtest: basic-fds
[325.867362] Subtest basic-fds: SUCCESS (7.442s)
[326.078535] [037/133] (787s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[326.192857] Starting subtest: psr-1p-primscrn-cur-indfb-move
[333.546949] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.358s)
[333.726953] [038/133] (779s left) gem_exec_schedule (preempt-user)
[333.801806] Starting subtest: preempt-user
[333.803624] Starting dynamic subtest: rcs0
[333.820487] Dynamic subtest rcs0: SUCCESS (0.023s)
[333.830082] Starting dynamic subtest: bcs0
[333.838919] Dynamic subtest bcs0: SUCCESS (0.018s)
[333.847506] Starting dynamic subtest: vcs0
[333.859693] Dynamic subtest vcs0: SUCCESS (0.020s)
[333.868038] Starting dynamic subtest: vcs1
[333.888289] Dynamic subtest vcs1: SUCCESS (0.028s)
[333.901406] Starting dynamic subtest: vecs0
[333.917996] Dynamic subtest vecs0: SUCCESS (0.029s)
[333.931226] Starting dynamic subtest: ccs0
[333.951792] Dynamic subtest ccs0: SUCCESS (0.033s)
[333.954087] Subtest preempt-user: SUCCESS (0.155s)
[335.059348] [039/133] (778s left) kms_psr (psr2-primary-mmap-cpu)
[335.163118] Starting subtest: psr2-primary-mmap-cpu
[335.165385] Starting dynamic subtest: eDP-1
[336.900042] Dynamic subtest eDP-1: SUCCESS (1.734s)
[336.902236] Subtest psr2-primary-mmap-cpu: SUCCESS (1.735s)
[337.798110] [040/133] (775s left) gem_ctx_param (invalid-size-set)
[337.857116] Starting subtest: invalid-size-set
[337.859529] Subtest invalid-size-set: SUCCESS (0.001s)
[337.990945] [041/133] (775s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[338.071073] Starting subtest: bad-aux-stride-y-tiled-ccs
[338.073365] Starting dynamic subtest: pipe-A-eDP-1
[338.096215] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[338.107117] Starting dynamic subtest: pipe-B-eDP-1
[338.128657] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[338.136590] Starting dynamic subtest: pipe-C-eDP-1
[338.158097] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[338.165979] Starting dynamic subtest: pipe-D-eDP-1
[338.188309] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[338.192775] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[340.267297] [042/133] (773s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[340.382641] Starting subtest: blocking-absolute-wf_vblank-interruptible
[340.384536] Starting dynamic subtest: A-eDP1
[349.109322] Dynamic subtest A-eDP1: SUCCESS (8.724s)
[349.121312] Starting dynamic subtest: B-eDP1
[357.832840] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[357.845436] Starting dynamic subtest: C-eDP1
[366.552302] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[366.569753] Starting dynamic subtest: D-eDP1
[375.287770] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[375.290073] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.907s)
[376.514217] [043/133] (737s left) kms_psr2_su (page_flip-nv12)
[376.577829] Subtest page_flip-NV12: SKIP (0.000s)
[376.664762] [044/133] (737s left) gem_exec_balancer (sliced)
[376.729547] Starting subtest: sliced
[376.734077] Subtest sliced: SKIP (0.000s)
[377.065326] [045/133] (736s left) kms_plane_lowres (tiling-x)
[377.179942] Starting subtest: tiling-x
[377.182265] Starting dynamic subtest: pipe-A-eDP-1
[377.186849] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[377.475235] Starting dynamic subtest: pipe-B-eDP-1
[377.479834] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[377.489501] Starting dynamic subtest: pipe-C-eDP-1
[377.494132] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[377.502135] Starting dynamic subtest: pipe-D-eDP-1
[377.506398] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[377.510780] Subtest tiling-x: SKIP (0.294s)
[378.336953] [046/133] (735s left) kms_vblank (query-busy-hang)
[378.426110] Starting subtest: query-busy-hang
[378.428428] Starting dynamic subtest: pipe-A-eDP-1
[405.659837] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.229s)
[405.673645] Starting dynamic subtest: pipe-D-eDP-1
[420.708117] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.046s)
[420.710373] Subtest query-busy-hang: SUCCESS (42.279s)
[421.615936] [047/133] (692s left) gem_exec_balancer (hang)
[421.881914] Starting subtest: hang
[423.936803] Subtest hang: SUCCESS (2.058s)
[424.090271] [048/133] (689s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[424.201480] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[424.205637] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[424.330702] [049/133] (689s left) kms_flip (bo-too-big)
[424.428480] Starting subtest: bo-too-big
[424.430708] Starting dynamic subtest: A-eDP1
[425.731092] Dynamic subtest A-eDP1: SUCCESS (1.301s)
[425.742159] Starting dynamic subtest: B-eDP1
[427.059821] Dynamic subtest B-eDP1: SUCCESS (1.328s)
[427.072197] Starting dynamic subtest: C-eDP1
[428.398024] Dynamic subtest C-eDP1: SUCCESS (1.338s)
[428.406772] Starting dynamic subtest: D-eDP1
[429.725185] Dynamic subtest D-eDP1: SUCCESS (1.326s)
[429.727510] Subtest bo-too-big: SUCCESS (5.300s)
[430.959317] [050/133] (683s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[431.020772] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[431.024995] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[431.228231] [051/133] (682s left) kms_cursor_legacy (single-bo)
[431.349330] Starting subtest: single-bo
[431.351471] Starting dynamic subtest: pipe-A
[436.731211] Dynamic subtest pipe-A: SUCCESS (5.379s)
[436.742707] Starting dynamic subtest: pipe-B
[442.113653] Dynamic subtest pipe-B: SUCCESS (5.379s)
[442.124514] Starting dynamic subtest: pipe-C
[447.494735] Dynamic subtest pipe-C: SUCCESS (5.378s)
[447.505874] Starting dynamic subtest: pipe-D
[452.875958] Dynamic subtest pipe-D: SUCCESS (5.379s)
[452.887015] Starting dynamic subtest: all-pipes
[458.265317] Dynamic subtest all-pipes: SUCCESS (5.387s)
[458.267893] Subtest single-bo: SUCCESS (26.915s)
[458.431115] [052/133] (655s left) kms_pm_rpm (basic-pci-d3-state)
[460.054998] Starting subtest: basic-pci-d3-state
[461.534140] Subtest basic-pci-d3-state: SUCCESS (1.481s)
[461.619695] [053/133] (652s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[461.715422] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[466.083303] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.370s)
[467.311722] [054/133] (646s left) kms_pm_rpm (legacy-planes)
[469.041747] Starting subtest: legacy-planes
[469.044241] Starting dynamic subtest: plane-63
[477.364818] Dynamic subtest plane-63: SUCCESS (8.325s)
[477.376560] Starting dynamic subtest: plane-93
[485.967347] Dynamic subtest plane-93: SUCCESS (8.601s)
[485.978754] Starting dynamic subtest: plane-123
[494.280364] Dynamic subtest plane-123: SUCCESS (8.311s)
[494.291207] Starting dynamic subtest: plane-133
[502.571617] Dynamic subtest plane-133: SUCCESS (8.289s)
[502.574220] Subtest legacy-planes: SUCCESS (33.534s)
[502.941458] [055/133] (611s left) prime_self_import (basic-with_one_bo)
[502.989621] Starting subtest: basic-with_one_bo
[503.010193] Subtest basic-with_one_bo: SUCCESS (0.023s)
[503.142231] [056/133] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[503.241609] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[503.245814] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[503.379801] [057/133] (610s left) kms_flip (modeset-vs-vblank-race)
[503.484909] Starting subtest: modeset-vs-vblank-race
[503.487266] Starting dynamic subtest: A-eDP1
[508.132941] Dynamic subtest A-eDP1: SUCCESS (4.649s)
[508.144308] Starting dynamic subtest: B-eDP1
[512.849050] Dynamic subtest B-eDP1: SUCCESS (4.714s)
[512.863734] Starting dynamic subtest: C-eDP1
[517.464332] Dynamic subtest C-eDP1: SUCCESS (4.612s)
[517.481496] Starting dynamic subtest: D-eDP1
[522.097898] Dynamic subtest D-eDP1: SUCCESS (4.631s)
[522.100105] Subtest modeset-vs-vblank-race: SUCCESS (18.618s)
[523.379522] [058/133] (590s left) gem_lmem_swapping (heavy-verify-random-ccs)
[523.426731] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[523.463329] [059/133] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[523.559643] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[523.564176] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[523.687252] [060/133] (590s left) kms_chamelium_color (gamma)
[523.779281] Subtest gamma: SKIP (0.000s)
[523.822697] [061/133] (590s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[523.943841] Starting subtest: cursorB-vs-flipA-varying-size
[523.948469] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[524.111272] [062/133] (590s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[524.213311] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[528.614717] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.406s)
[529.785923] [063/133] (584s left) dumb_buffer (map-valid)
[529.846964] Starting subtest: map-valid
[529.848961] Subtest map-valid: SUCCESS (0.000s)
[529.974245] [064/133] (584s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[530.070281] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[530.072567] Starting dynamic subtest: pipe-A-default-mode
[530.380383] Dynamic subtest pipe-A-default-mode: SKIP (0.308s)
[530.385284] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.311s)
[531.201123] [065/133] (583s left) perf (i915-ref-count)
[531.290321] Starting subtest: i915-ref-count
[531.351674] Subtest i915-ref-count: SUCCESS (0.060s)
[531.405146] [066/133] (583s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[531.507348] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[531.511799] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[531.652854] [067/133] (582s left) gem_softpin (noreloc-interruptible)
[531.719895] Starting subtest: noreloc-interruptible
[537.105079] Subtest noreloc-interruptible: SUCCESS (5.384s)
[537.274070] [068/133] (577s left) kms_psr (fbc-psr2-primary-render)
[537.378033] Starting subtest: fbc-psr2-primary-render
[537.380364] Starting dynamic subtest: eDP-1
[537.384807] Dynamic subtest eDP-1: SKIP (0.000s)
[537.389248] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[537.475265] [069/133] (577s left) kms_lease (atomic-implicit-crtc)
[537.579917] Starting subtest: atomic-implicit-crtc
[537.582206] Starting dynamic subtest: pipe-A-eDP-1
[537.593493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[537.603049] Starting dynamic subtest: pipe-B-eDP-1
[537.614142] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[537.622761] Starting dynamic subtest: pipe-C-eDP-1
[537.633837] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[537.642122] Starting dynamic subtest: pipe-D-eDP-1
[537.652850] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[537.655106] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[537.779204] [070/133] (576s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[537.868068] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[538.251482] Starting dynamic subtest: pipe-A-eDP-1
[541.047661] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.796s)
[541.418768] Starting dynamic subtest: pipe-B-eDP-1
[544.169073] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.760s)
[544.531750] Starting dynamic subtest: pipe-C-eDP-1
[547.301871] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.775s)
[547.667583] Starting dynamic subtest: pipe-D-eDP-1
[550.437087] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[550.439611] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.570s)
[551.643790] [071/133] (563s left) gem_exec_reloc (basic-wc-read-active)
[551.719496] Subtest basic-wc-read-active: SKIP (0.000s)
[551.796489] [072/133] (563s left) gem_readwrite (new-obj)
[551.854477] Subtest new-obj: SKIP (0.000s)
[551.915593] [073/133] (562s left) gem_mmap_gtt (basic-short)
[551.981018] Subtest basic-short: SKIP (0.000s)
[552.041793] [074/133] (562s left) kms_plane_multiple (tiling-yf)
[552.137679] Starting subtest: tiling-yf
[552.141824] Subtest tiling-yf: SKIP (0.000s)
[552.234636] [075/133] (562s left) kms_content_protection (dp-mst-type-0-hdcp14)
[552.375030] Starting subtest: dp-mst-type-0-hdcp14
[552.379774] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[552.516304] [076/133] (562s left) gem_ctx_shared (q-in-order)
[552.589330] Starting subtest: Q-in-order
[552.591324] Starting dynamic subtest: rcs0
[552.774800] Dynamic subtest rcs0: SUCCESS (0.186s)
[552.791226] Starting dynamic subtest: vcs0
[552.853555] Dynamic subtest vcs0: SUCCESS (0.078s)
[552.869999] Starting dynamic subtest: vcs1
[552.928967] Dynamic subtest vcs1: SUCCESS (0.075s)
[552.945207] Starting dynamic subtest: vecs0
[553.004690] Dynamic subtest vecs0: SUCCESS (0.075s)
[553.020429] Starting dynamic subtest: ccs0
[553.092290] Dynamic subtest ccs0: SUCCESS (0.087s)
[553.094816] Subtest Q-in-order: SUCCESS (0.505s)
[554.074912] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[554.078155] [077/133] (560s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[554.139448] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[554.239528] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[554.343140] [078/133] (560s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[554.452983] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[561.136027] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.682s)
[561.297183] [079/133] (553s left) kms_big_fb (linear-8bpp-rotate-270)
[561.411578] Starting subtest: linear-8bpp-rotate-270
[561.432842] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[561.584089] [080/133] (553s left) api_intel_allocator (standalone)
[561.644349] Starting subtest: standalone
[561.657749] Subtest standalone: SUCCESS (0.016s)
[561.816606] [081/133] (553s left) core_auth (getclient-master-drop)
[561.849544] Starting subtest: getclient-master-drop
[561.872528] Subtest getclient-master-drop: SUCCESS (0.024s)
[562.006814] [082/133] (553s left) kms_psr (fbc-psr2-basic)
[562.109152] Starting subtest: fbc-psr2-basic
[562.111444] Starting dynamic subtest: eDP-1
[562.115775] Dynamic subtest eDP-1: SKIP (0.000s)
[562.120123] Subtest fbc-psr2-basic: SKIP (0.001s)
[562.205893] [083/133] (553s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[562.361279] Starting subtest: cursor-rapid-movement-32x32
[562.408756] Subtest cursor-rapid-movement-32x32: SKIP (0.044s)
[562.737055] [084/133] (552s left) gem_exec_schedule (noreorder-priority)
[562.926650] Starting subtest: noreorder-priority
[562.929147] Starting dynamic subtest: rcs0
[564.069365] Dynamic subtest rcs0: SUCCESS (1.143s)
[564.081918] Starting dynamic subtest: vcs0
[565.936627] Dynamic subtest vcs0: SUCCESS (1.864s)
[565.948812] Starting dynamic subtest: vcs1
[567.874518] Dynamic subtest vcs1: SUCCESS (1.935s)
[567.884478] Starting dynamic subtest: vecs0
[569.923523] Dynamic subtest vecs0: SUCCESS (2.047s)
[569.936108] Starting dynamic subtest: ccs0
[571.072915] Dynamic subtest ccs0: SUCCESS (1.148s)
[571.075695] Subtest noreorder-priority: SUCCESS (8.148s)
[571.284436] [085/133] (544s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[571.379089] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[571.381493] Starting dynamic subtest: pipe-A-eDP-1
[571.407693] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[571.418300] Starting dynamic subtest: pipe-B-eDP-1
[571.442610] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[571.450752] Starting dynamic subtest: pipe-C-eDP-1
[571.474344] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[571.484148] Starting dynamic subtest: pipe-D-eDP-1
[571.507656] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[571.512084] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[573.645941] [086/133] (541s left) core_auth (many-magics)
[573.713139] Starting subtest: many-magics
[574.597075] Subtest many-magics: SUCCESS (0.885s)
[574.830284] [087/133] (540s left) i915_suspend (fence-restore-tiled2untiled)
[574.891858] Starting subtest: fence-restore-tiled2untiled
[574.896613] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[575.037282] [088/133] (540s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[575.134798] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[575.137047] Starting dynamic subtest: pipe-A
[575.155998] Dynamic subtest pipe-A: SKIP (0.017s)
[575.165215] Starting dynamic subtest: pipe-B
[575.187516] Dynamic subtest pipe-B: SKIP (0.030s)
[575.196510] Starting dynamic subtest: pipe-C
[575.219013] Dynamic subtest pipe-C: SKIP (0.030s)
[575.227807] Starting dynamic subtest: pipe-D
[575.257546] Dynamic subtest pipe-D: SKIP (0.039s)
[575.261979] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.120s)
[575.394824] [089/133] (540s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[575.504700] Starting subtest: y-tiled-64bpp-rotate-0
[575.509138] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[575.634532] [090/133] (539s left) gem_ctx_persistence (saturated-hostile)
[575.692916] Starting subtest: saturated-hostile
[575.695135] Starting dynamic subtest: rcs0
[576.539457] Dynamic subtest rcs0: SUCCESS (0.846s)
[576.552114] Starting dynamic subtest: bcs0
[577.347823] Dynamic subtest bcs0: SUCCESS (0.806s)
[577.357601] Starting dynamic subtest: vcs0
[578.174092] Dynamic subtest vcs0: SUCCESS (0.824s)
[578.183631] Starting dynamic subtest: vcs1
[578.987462] Dynamic subtest vcs1: SUCCESS (0.811s)
[578.998583] Starting dynamic subtest: vecs0
[579.810522] Dynamic subtest vecs0: SUCCESS (0.821s)
[579.820846] Starting dynamic subtest: ccs0
[580.677917] Dynamic subtest ccs0: SUCCESS (0.865s)
[580.680370] Subtest saturated-hostile: SUCCESS (4.985s)
[580.781622] [091/133] (534s left) kms_prop_blob (invalid-get-prop)
[580.841714] Starting subtest: invalid-get-prop
[580.843632] Subtest invalid-get-prop: SUCCESS (0.000s)
[580.980465] [092/133] (534s left) gem_mmap_gtt (basic-write)
[581.037997] Subtest basic-write: SKIP (0.000s)
[581.105874] [093/133] (534s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[581.240938] Starting subtest: cursorA-vs-flipA-varying-size
[592.368440] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.126s)
[593.181111] [094/133] (522s left) gem_linear_blits (interruptible)
[593.553978] Starting subtest: interruptible
[597.905989] Subtest interruptible: SUCCESS (4.351s)
[598.082975] [095/133] (517s left) gem_exec_params (sol-reset-invalid)
[598.181007] Starting subtest: sol-reset-invalid
[598.186172] Subtest sol-reset-invalid: SUCCESS (0.003s)
[600.013412] [096/133] (515s left) kms_color_pipeline (plane-lut1d)
[600.119065] Starting subtest: plane-lut1d
[600.131981] Starting dynamic subtest: pipe-A-eDP-1
[600.862552] Dynamic subtest pipe-A-eDP-1: FAIL (0.343s)
[601.534089] Starting dynamic subtest: pipe-B-eDP-1
[602.343273] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[602.876846] Starting dynamic subtest: pipe-C-eDP-1
[603.710798] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[604.204829] Starting dynamic subtest: pipe-D-eDP-1
[605.037980] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[605.040429] Subtest plane-lut1d: FAIL (4.608s)
[605.607723] [097/133] (510s left) gem_wait (busy)
[605.677588] Starting subtest: busy
[605.679777] Starting dynamic subtest: all-engines
[606.931907] Dynamic subtest all-engines: SUCCESS (1.256s)
[606.944052] Starting dynamic subtest: rcs0
[607.472977] Dynamic subtest rcs0: SUCCESS (0.540s)
[607.484831] Starting dynamic subtest: bcs0
[608.012281] Dynamic subtest bcs0: SUCCESS (0.538s)
[608.023955] Starting dynamic subtest: vcs0
[609.877079] Dynamic subtest vcs0: SUCCESS (1.863s)
[609.889533] Starting dynamic subtest: vcs1
[611.924661] Dynamic subtest vcs1: SUCCESS (2.045s)
[611.936745] Starting dynamic subtest: vecs0
[613.908568] Dynamic subtest vecs0: SUCCESS (1.980s)
[613.920695] Starting dynamic subtest: ccs0
[614.451164] Dynamic subtest ccs0: SUCCESS (0.542s)
[614.453548] Subtest busy: SUCCESS (8.777s)
[614.676290] [098/133] (501s left) sriov_basic (enable-vfs-autoprobe-on)
[614.740035] Starting subtest: enable-vfs-autoprobe-on
[614.742471] Starting dynamic subtest: numvfs-1
[614.817090] Dynamic subtest numvfs-1: FAIL (0.005s)
[614.825669] Starting dynamic subtest: numvfs-2
[614.898073] Dynamic subtest numvfs-2: FAIL (0.003s)
[614.908824] Starting dynamic subtest: numvfs-3
[614.981336] Dynamic subtest numvfs-3: FAIL (0.003s)
[614.991950] Starting dynamic subtest: numvfs-4
[615.064784] Dynamic subtest numvfs-4: FAIL (0.003s)
[615.075067] Starting dynamic subtest: numvfs-5
[615.147740] Dynamic subtest numvfs-5: FAIL (0.003s)
[615.158057] Starting dynamic subtest: numvfs-6
[615.230499] Dynamic subtest numvfs-6: FAIL (0.003s)
[615.240932] Starting dynamic subtest: numvfs-7
[615.312645] Dynamic subtest numvfs-7: FAIL (0.003s)
[615.321133] Starting dynamic subtest: numvfs-random
[615.391180] Dynamic subtest numvfs-random: FAIL (0.003s)
[615.401358] Starting dynamic subtest: numvfs-all
[615.473994] Dynamic subtest numvfs-all: FAIL (0.509s)
[615.476055] Subtest enable-vfs-autoprobe-on: FAIL (0.544s)
[615.513932] [099/133] (500s left) kms_chamelium_frames (vga-frame-dump)
[615.893327] Subtest vga-frame-dump: SKIP (0.000s)
[616.687367] [100/133] (499s left) gem_eio (throttle)
[616.880252] Starting subtest: throttle
[617.141306] Subtest throttle: SUCCESS (0.262s)
[617.321850] [101/133] (498s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[617.420745] Starting subtest: psr-abgr161616f-draw-mmap-wc
[617.425170] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[617.554977] [102/133] (498s left) gem_softpin (allocator-nopin)
[617.620450] Starting subtest: allocator-nopin
[617.708087] Subtest allocator-nopin: SUCCESS (0.088s)
[617.861240] [103/133] (498s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[617.972741] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[618.653163] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[618.827177] [104/133] (497s left) kms_flip (busy-flip)
[618.920751] Starting subtest: busy-flip
[618.923056] Starting dynamic subtest: A-eDP1
[620.607212] Dynamic subtest A-eDP1: SUCCESS (1.686s)
[620.618935] Starting dynamic subtest: B-eDP1
[622.247269] Dynamic subtest B-eDP1: SUCCESS (1.638s)
[622.259478] Starting dynamic subtest: C-eDP1
[623.875909] Dynamic subtest C-eDP1: SUCCESS (1.627s)
[623.889457] Starting dynamic subtest: D-eDP1
[625.517796] Dynamic subtest D-eDP1: SUCCESS (1.640s)
[625.520226] Subtest busy-flip: SUCCESS (6.600s)
[626.821319] [105/133] (489s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[626.925122] Starting subtest: x-tiled-16bpp-rotate-270
[626.944577] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[627.101395] [106/133] (489s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[627.221621] Starting subtest: fbcpsr-abgr161616f-draw-render
[627.225752] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[627.331346] [107/133] (488s left) kms_getfb (getfb2-accept-nv12)
[627.424815] Starting subtest: getfb2-accept-nv12
[627.426995] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[627.561085] [108/133] (488s left) gem_ctx_exec (basic-nohangcheck)
[627.626155] Starting subtest: basic-nohangcheck
[627.879600] Subtest basic-nohangcheck: SUCCESS (0.254s)
[628.040942] [109/133] (488s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[628.165445] Starting subtest: short-flip-before-cursor-atomic-transitions
[629.136433] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.969s)
[630.032983] [110/133] (486s left) kms_cursor_crc (cursor-offscreen-256x256)
[630.267807] Starting subtest: cursor-offscreen-256x256
[630.270043] Starting dynamic subtest: pipe-A-eDP-1
[632.249216] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.978s)
[632.282612] Starting dynamic subtest: pipe-D-eDP-1
[634.819752] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s)
[634.822064] Subtest cursor-offscreen-256x256: SUCCESS (4.554s)
[635.709977] [111/133] (480s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[635.820719] Starting subtest: 4-tiled-8bpp-rotate-0
[637.024796] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.203s)
[637.186007] [112/133] (479s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[637.244537] Subtest writes-after-reads: SKIP (0.000s)
[637.329206] [113/133] (479s left) kms_frontbuffer_tracking (psr-slowdraw)
[637.421474] Starting subtest: psr-slowdraw
[662.571179] Subtest psr-slowdraw: SUCCESS (25.151s)
[662.744987] [114/133] (453s left) i915_pm_rc6_residency (rc6-idle)
[662.805278] Starting subtest: rc6-idle
[662.830245] Starting dynamic subtest: gt0-rcs0
[687.258152] Dynamic subtest gt0-rcs0: SUCCESS (24.427s)
[687.270209] Starting dynamic subtest: gt0-bcs0
[711.542153] Dynamic subtest gt0-bcs0: SUCCESS (24.281s)
[711.551455] Starting dynamic subtest: gt0-ccs0
[735.957106] Dynamic subtest gt0-ccs0: SUCCESS (24.412s)
[735.969339] Starting dynamic subtest: gt1-vcs0
[742.131965] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[742.143795] Starting dynamic subtest: gt1-vecs0
[748.303904] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[748.307261] Subtest rc6-idle: SUCCESS (85.499s)
[748.412446] [115/133] (368s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[748.510276] Starting subtest: fbc-modesetfrombusy
[752.360056] Subtest fbc-modesetfrombusy: SUCCESS (3.855s)
[753.573482] [116/133] (363s left) kms_psr (psr-cursor-render)
[753.676875] Starting subtest: psr-cursor-render
[753.679145] Starting dynamic subtest: eDP-1
[755.408630] Dynamic subtest eDP-1: SUCCESS (1.732s)
[755.411108] Subtest psr-cursor-render: SUCCESS (1.733s)
[756.306757] [117/133] (360s left) gem_exec_parallel (engines)
[756.360870] Starting subtest: engines
[756.363126] Starting dynamic subtest: basic
[757.956418] Dynamic subtest basic: SUCCESS (1.595s)
[757.969603] Starting dynamic subtest: contexts
[762.373975] Dynamic subtest contexts: SUCCESS (4.412s)
[762.385503] Starting dynamic subtest: fds
[766.127718] Dynamic subtest fds: SUCCESS (3.751s)
[766.140585] Starting dynamic subtest: userptr
[767.935739] Dynamic subtest userptr: SUCCESS (1.783s)
[767.942186] Subtest engines: SUCCESS (11.551s)
[768.132851] [118/133] (348s left) prime_busy (after)
[768.204287] Starting subtest: after
[768.210147] Starting dynamic subtest: rcs0
[768.261367] Dynamic subtest rcs0: SUCCESS (0.053s)
[768.272847] Starting dynamic subtest: bcs0
[768.338849] Dynamic subtest bcs0: SUCCESS (0.076s)
[768.349019] Starting dynamic subtest: vcs0
[768.379441] Dynamic subtest vcs0: SUCCESS (0.040s)
[768.388605] Starting dynamic subtest: vcs1
[768.421676] Dynamic subtest vcs1: SUCCESS (0.042s)
[768.430688] Starting dynamic subtest: vecs0
[768.463057] Dynamic subtest vecs0: SUCCESS (0.041s)
[768.472259] Starting dynamic subtest: ccs0
[768.505730] Dynamic subtest ccs0: SUCCESS (0.042s)
[768.615354] Subtest after: SUCCESS (0.409s)
[768.715830] [119/133] (348s left) gem_partial_pwrite_pread (write-display)
[768.778664] Subtest write-display: SKIP (0.000s)
[768.864365] [120/133] (347s left) gem_tiled_blits (basic)
[768.923833] Subtest basic: SKIP (0.000s)
[769.003894] [121/133] (347s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[769.108575] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[777.431752] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.324s)
[777.578371] [122/133] (339s left) sysfs_defaults (readonly)
[777.635035] Starting subtest: readonly
[777.637305] Starting dynamic subtest: vecs0
[777.639529] Dynamic subtest vecs0: SUCCESS (0.000s)
[777.648674] Starting dynamic subtest: ccs0
[777.650887] Dynamic subtest ccs0: SUCCESS (0.000s)
[777.659824] Starting dynamic subtest: vcs0
[777.662084] Dynamic subtest vcs0: SUCCESS (0.000s)
[777.670972] Starting dynamic subtest: bcs0
[777.673199] Dynamic subtest bcs0: SUCCESS (0.000s)
[777.682018] Starting dynamic subtest: rcs0
[777.684275] Dynamic subtest rcs0: SUCCESS (0.000s)
[777.693390] Starting dynamic subtest: vcs1
[777.695273] Dynamic subtest vcs1: SUCCESS (0.000s)
[777.697148] Subtest readonly: SUCCESS (0.005s)
[777.774610] [123/133] (339s left) kms_dsc (dsc-with-formats)
[777.887034] Starting subtest: dsc-with-formats
[777.927302] Subtest dsc-with-formats: SKIP (0.001s)
[777.979811] [124/133] (339s left) prime_mmap (test_reprime)
[778.040602] Starting subtest: test_reprime
[778.042871] Starting dynamic subtest: test_reprime-smem
[778.068480] Dynamic subtest test_reprime-smem: SUCCESS (0.030s)
[778.070954] Subtest test_reprime: SUCCESS (0.031s)
[778.192056] [125/133] (338s left) gem_exec_params (rsvd2-dirt)
[778.255331] Starting subtest: rsvd2-dirt
[778.259958] Subtest rsvd2-dirt: SKIP (0.000s)
[778.375736] [126/133] (338s left) kms_lease (lessee-list)
[778.467733] Starting subtest: lessee-list
[778.469645] Starting dynamic subtest: pipe-A-eDP-1
[778.471523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[778.482106] Starting dynamic subtest: pipe-B-eDP-1
[778.483871] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[778.492702] Starting dynamic subtest: pipe-C-eDP-1
[778.494477] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[778.503036] Starting dynamic subtest: pipe-D-eDP-1
[778.504925] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[778.506794] Subtest lessee-list: SUCCESS (0.008s)
[778.598210] [127/133] (338s left) kms_vrr (flip-dpms)
[778.698338] Starting subtest: flip-dpms
[778.703809] Subtest flip-dpms: SKIP (0.000s)
[778.789873] [128/133] (338s left) kms_frontbuffer_tracking (fbc-1p-rte)
[778.902602] Starting subtest: fbc-1p-rte
[784.386178] Subtest fbc-1p-rte: SUCCESS (5.486s)
[785.606464] [129/133] (331s left) gen9_exec_parse (batch-zero-length)
[785.672333] Subtest batch-zero-length: SKIP (0.000s)
[785.737436] [130/133] (331s left) prime_mmap (test_aperture_limit)
[785.788170] Starting subtest: test_aperture_limit
[785.790077] Starting dynamic subtest: test_aperture_limit-smem
[785.796992] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[785.801192] Subtest test_aperture_limit: SKIP (0.008s)
[785.914485] [131/133] (331s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[786.012839] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[786.017147] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[786.151669] [132/133] (331s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[786.251083] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[786.255181] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[786.382408] [133/133] (330s left) gem_exec_fence (long-history)
[786.873892] Starting subtest: long-history
[793.682568] Subtest long-history: SUCCESS (6.809s)
[794.219656] 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.