[57.184873] Initializing watchdogs
[57.184918]   /dev/watchdog0
[57.199441] [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]
[57.203776] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.206129] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.209434] [001/133] (960s left) gem_create (create-ext-placement-all)
[57.388053] Starting subtest: create-ext-placement-all
[57.390766] Subtest create-ext-placement-all: SUCCESS (0.000s)
[57.527622] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[57.603963] Starting subtest: map-fixed-invalidate-overlap
[57.608079] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[57.768631] [003/133] (960s left) gem_pipe_control_store_loop (fresh-buffer)
[57.831916] Starting subtest: fresh-buffer
[59.979790] Subtest fresh-buffer: SUCCESS (2.154s)
[60.133614] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[60.198046] Starting subtest: mmap-boundaries
[60.200114] Starting dynamic subtest: smem0
[60.481437] Dynamic subtest smem0: SUCCESS (0.285s)
[60.483941] Subtest mmap-boundaries: SUCCESS (0.286s)
[60.668482] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[60.784079] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[68.389620] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.624s)
[68.548315] [006/133] (949s left) kms_atomic (atomic-plane-damage)
[68.646658] Starting subtest: atomic-plane-damage
[68.731714] Starting dynamic subtest: pipe-A-eDP-1
[69.250351] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.520s)
[69.252726] Subtest atomic-plane-damage: SUCCESS (0.604s)
[70.081557] [007/133] (947s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[70.174335] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[70.176641] Starting dynamic subtest: pipe-A-eDP-1
[70.236243] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[70.245738] Starting dynamic subtest: pipe-B-eDP-1
[70.299709] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.062s)
[70.313673] Starting dynamic subtest: pipe-C-eDP-1
[70.362735] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.063s)
[70.370546] Starting dynamic subtest: pipe-D-eDP-1
[70.425759] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.062s)
[70.428026] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.255s)
[72.735572] [008/133] (945s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[72.831511] Starting subtest: psr-rgb101010-draw-mmap-wc
[79.906814] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.081s)
[80.038624] [009/133] (937s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[80.109652] Starting subtest: yf-tiled-to-vebox-x-tiled
[80.113741] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[80.309551] [010/133] (937s left) syncobj_timeline (wait-all-complex)
[80.364656] Starting subtest: wait-all-complex
[80.577297] Subtest wait-all-complex: SUCCESS (0.212s)
[80.672136] [011/133] (937s left) gem_pxp (create-valid-protected-context)
[80.804781] Starting subtest: create-valid-protected-context
[80.807459] Subtest create-valid-protected-context: SUCCESS (0.002s)
[80.947218] [012/133] (937s left) gem_exec_flush (basic-wb-rw-default)
[81.017442] Starting subtest: basic-wb-rw-default
[86.467385] Subtest basic-wb-rw-default: SUCCESS (5.451s)
[86.678609] [013/133] (931s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[86.780747] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[86.782998] Starting dynamic subtest: pipe-A-eDP-1
[86.803060] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[86.811139] Starting dynamic subtest: pipe-B-eDP-1
[86.830515] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[86.838167] Starting dynamic subtest: pipe-C-eDP-1
[86.857174] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[86.864881] Starting dynamic subtest: pipe-D-eDP-1
[86.883674] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[86.885796] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[89.119830] [014/133] (929s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[89.232208] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[93.329617] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.101s)
[94.512995] [015/133] (923s left) kms_cursor_edge_walk (256x256-top-bottom)
[94.615083] Starting subtest: 256x256-top-bottom
[94.617432] Starting dynamic subtest: pipe-A-eDP-1
[98.043766] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s)
[98.052226] Starting dynamic subtest: pipe-D-eDP-1
[101.159767] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[101.162070] Subtest 256x256-top-bottom: SUCCESS (6.546s)
[101.994657] [016/133] (916s left) kms_force_connector_basic (force-load-detect)
[102.086399] Starting subtest: force-load-detect
[102.090846] Subtest force-load-detect: SKIP (0.000s)
[102.220161] [017/133] (916s left) syncobj_wait (invalid-signal-zero-handles)
[102.294860] Starting subtest: invalid-signal-zero-handles
[102.297128] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[102.412296] [018/133] (915s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[107.474105] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[107.476315] Starting dynamic subtest: pipe-A-eDP-1
[108.258263] Dynamic subtest pipe-A-eDP-1: SKIP (0.781s)
[108.266395] Starting dynamic subtest: pipe-B-eDP-1
[109.383733] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[109.388030] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.908s)
[110.588982] [019/133] (907s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[110.707378] Starting subtest: fbcpsr-rgb565-draw-render
[117.709541] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.005s)
[117.866928] [020/133] (900s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[117.963352] Starting subtest: primary-4-tiled-reflect-x-0
[125.067084] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.105s)
[126.290793] [021/133] (892s left) kms_setmode (clone-exclusive-crtc)
[126.353993] Starting subtest: clone-exclusive-crtc
[126.360594] Subtest clone-exclusive-crtc: SKIP (0.000s)
[126.491096] [022/133] (892s left) kms_addfb_basic (too-high)
[126.591994] Starting subtest: too-high
[126.594244] Subtest too-high: SUCCESS (0.001s)
[126.708534] [023/133] (891s left) perf_pmu (busy-accuracy-2)
[126.747922] Starting subtest: busy-accuracy-2
[126.750330] Starting dynamic subtest: rcs0
[129.787806] Dynamic subtest rcs0: SUCCESS (3.038s)
[129.798773] Starting dynamic subtest: bcs0
[132.845934] Dynamic subtest bcs0: SUCCESS (3.057s)
[132.856687] Starting dynamic subtest: vcs0
[135.892089] Dynamic subtest vcs0: SUCCESS (3.044s)
[135.902647] Starting dynamic subtest: vcs1
[138.938449] Dynamic subtest vcs1: SUCCESS (3.045s)
[138.948957] Starting dynamic subtest: vecs0
[141.984602] Dynamic subtest vecs0: SUCCESS (3.044s)
[141.995478] Starting dynamic subtest: ccs0
[145.038790] Dynamic subtest ccs0: SUCCESS (3.052s)
[145.041261] Subtest busy-accuracy-2: SUCCESS (18.290s)
[145.177327] [024/133] (873s left) kms_psr (pr-primary-mmap-gtt)
[145.282599] Starting subtest: pr-primary-mmap-gtt
[145.286809] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[145.376246] [025/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[145.478484] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[145.482873] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[145.605987] [026/133] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[145.711257] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[145.715469] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[145.846095] [027/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[145.941290] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[145.943584] Starting dynamic subtest: pipe-A-default-mode
[148.713741] Dynamic subtest pipe-A-default-mode: SUCCESS (2.771s)
[148.716201] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.773s)
[149.590460] [028/133] (869s left) i915_drm_fdinfo (idle)
[149.635762] Starting subtest: idle
[149.638298] Starting dynamic subtest: rcs0
[150.251995] Dynamic subtest rcs0: SUCCESS (0.618s)
[150.262306] Starting dynamic subtest: bcs0
[150.764867] Dynamic subtest bcs0: SUCCESS (0.505s)
[150.775464] Starting dynamic subtest: vcs0
[151.267360] Dynamic subtest vcs0: SUCCESS (0.503s)
[151.278301] Starting dynamic subtest: vcs1
[151.773084] Dynamic subtest vcs1: SUCCESS (0.504s)
[151.783854] Starting dynamic subtest: vecs0
[152.278427] Dynamic subtest vecs0: SUCCESS (0.503s)
[152.289433] Starting dynamic subtest: ccs0
[152.787497] Dynamic subtest ccs0: SUCCESS (0.504s)
[152.789915] Subtest idle: SUCCESS (3.150s)
[152.881792] [029/133] (865s left) core_setmaster (master-drop-set-shared-fd)
[152.989506] Starting subtest: master-drop-set-shared-fd
[153.011124] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[153.046609] [030/133] (865s left) kms_chamelium_color (ctm-negative)
[153.143266] Subtest ctm-negative: SKIP (0.000s)
[153.186701] [031/133] (865s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[153.238216] Starting subtest: multi-wait-for-submit-available-submitted
[153.240133] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[153.343924] [032/133] (865s left) syncobj_timeline (invalid-signal-illegal-point)
[153.394829] Starting subtest: invalid-signal-illegal-point
[153.397045] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[153.521250] [033/133] (865s left) gem_mmap (bad-offset)
[153.595601] Subtest bad-offset: SKIP (0.000s)
[153.661419] [034/133] (865s left) i915_hangman (gt-error-state-capture)
[153.721727] Starting subtest: gt-error-state-capture
[153.723625] Starting dynamic subtest: rcs0
[164.854312] Dynamic subtest rcs0: SUCCESS (11.131s)
[164.866873] Starting dynamic subtest: bcs0
[176.887252] Dynamic subtest bcs0: SUCCESS (12.030s)
[176.899182] Starting dynamic subtest: vcs0
[188.854308] Dynamic subtest vcs0: SUCCESS (11.965s)
[188.865714] Starting dynamic subtest: vcs1
[200.821628] Dynamic subtest vcs1: SUCCESS (11.965s)
[200.833346] Starting dynamic subtest: vecs0
[211.830958] Dynamic subtest vecs0: SUCCESS (11.006s)
[211.842599] Starting dynamic subtest: ccs0
[221.878096] Dynamic subtest ccs0: SUCCESS (10.045s)
[221.881941] Subtest gt-error-state-capture: SUCCESS (68.155s)
[221.978999] [035/133] (797s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[222.098723] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[222.100929] Starting dynamic subtest: pipe-A-eDP-1
[222.109592] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[222.119827] Starting dynamic subtest: pipe-B-eDP-1
[222.128419] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[222.136804] Starting dynamic subtest: pipe-C-eDP-1
[222.144758] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[222.152842] Starting dynamic subtest: pipe-D-eDP-1
[222.160936] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[222.164823] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[224.432773] [036/133] (794s left) gem_exec_whisper (basic-fds)
[224.507722] Starting subtest: basic-fds
[231.926954] Subtest basic-fds: SUCCESS (7.416s)
[232.137326] [037/133] (786s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[232.245994] Starting subtest: psr-1p-primscrn-cur-indfb-move
[239.637456] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.393s)
[239.760522] [038/133] (779s left) gem_exec_schedule (preempt-user)
[239.837777] Starting subtest: preempt-user
[239.840030] Starting dynamic subtest: rcs0
[239.851398] Dynamic subtest rcs0: SUCCESS (0.022s)
[239.861518] Starting dynamic subtest: bcs0
[239.870250] Dynamic subtest bcs0: SUCCESS (0.018s)
[239.879496] Starting dynamic subtest: vcs0
[239.890825] Dynamic subtest vcs0: SUCCESS (0.020s)
[239.899823] Starting dynamic subtest: vcs1
[239.910820] Dynamic subtest vcs1: SUCCESS (0.019s)
[239.920509] Starting dynamic subtest: vecs0
[239.931568] Dynamic subtest vecs0: SUCCESS (0.020s)
[239.940552] Starting dynamic subtest: ccs0
[239.952769] Dynamic subtest ccs0: SUCCESS (0.020s)
[239.955142] Subtest preempt-user: SUCCESS (0.124s)
[241.995520] [039/133] (777s left) kms_psr (psr2-primary-mmap-cpu)
[242.084052] Starting subtest: psr2-primary-mmap-cpu
[242.086655] Starting dynamic subtest: eDP-1
[243.793425] Dynamic subtest eDP-1: SUCCESS (1.708s)
[243.795783] Subtest psr2-primary-mmap-cpu: SUCCESS (1.709s)
[244.689798] [040/133] (774s left) gem_ctx_param (invalid-size-set)
[244.745465] Starting subtest: invalid-size-set
[244.747875] Subtest invalid-size-set: SUCCESS (0.001s)
[244.881605] [041/133] (774s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[244.973034] Starting subtest: bad-aux-stride-y-tiled-ccs
[244.975143] Starting dynamic subtest: pipe-A-eDP-1
[244.997017] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[245.007174] Starting dynamic subtest: pipe-B-eDP-1
[245.027662] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[245.036537] Starting dynamic subtest: pipe-C-eDP-1
[245.057909] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[245.066340] Starting dynamic subtest: pipe-D-eDP-1
[245.088207] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[245.092285] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[247.158620] [042/133] (772s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[247.259295] Starting subtest: blocking-absolute-wf_vblank-interruptible
[247.261626] Starting dynamic subtest: A-eDP1
[255.991659] Dynamic subtest A-eDP1: SUCCESS (8.731s)
[256.002801] Starting dynamic subtest: B-eDP1
[264.718587] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[264.729474] Starting dynamic subtest: C-eDP1
[273.427750] Dynamic subtest C-eDP1: SUCCESS (8.708s)
[273.437134] Starting dynamic subtest: D-eDP1
[282.157628] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[282.163783] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.901s)
[283.390600] [043/133] (735s left) kms_psr2_su (page_flip-nv12)
[283.450702] Subtest page_flip-NV12: SKIP (0.000s)
[283.512108] [044/133] (735s left) gem_exec_balancer (sliced)
[283.573302] Starting subtest: sliced
[283.577950] Subtest sliced: SKIP (0.000s)
[283.883613] [045/133] (735s left) kms_plane_lowres (tiling-x)
[283.970077] Starting subtest: tiling-x
[283.972194] Starting dynamic subtest: pipe-A-eDP-1
[283.976554] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[284.266752] Starting dynamic subtest: pipe-B-eDP-1
[284.271193] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[284.279789] Starting dynamic subtest: pipe-C-eDP-1
[284.284141] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[284.292623] Starting dynamic subtest: pipe-D-eDP-1
[284.296989] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[284.301218] Subtest tiling-x: SKIP (0.295s)
[285.115811] [046/133] (734s left) kms_vblank (query-busy-hang)
[285.220485] Starting subtest: query-busy-hang
[285.222699] Starting dynamic subtest: pipe-A-eDP-1
[311.640070] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.414s)
[311.655286] Starting dynamic subtest: pipe-D-eDP-1
[336.735663] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.092s)
[336.737628] Subtest query-busy-hang: SUCCESS (51.511s)
[337.573994] [047/133] (681s left) gem_exec_balancer (hang)
[337.843672] Starting subtest: hang
[339.954274] Subtest hang: SUCCESS (2.114s)
[340.118361] [048/133] (679s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[340.229814] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[340.234066] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[340.349237] [049/133] (679s left) kms_flip (bo-too-big)
[340.448159] Starting subtest: bo-too-big
[340.450391] Starting dynamic subtest: A-eDP1
[341.800018] Dynamic subtest A-eDP1: SUCCESS (1.351s)
[341.814364] Starting dynamic subtest: B-eDP1
[343.131525] Dynamic subtest B-eDP1: SUCCESS (1.329s)
[343.142162] Starting dynamic subtest: C-eDP1
[344.462333] Dynamic subtest C-eDP1: SUCCESS (1.330s)
[344.472938] Starting dynamic subtest: D-eDP1
[345.796056] Dynamic subtest D-eDP1: SUCCESS (1.333s)
[345.798506] Subtest bo-too-big: SUCCESS (5.351s)
[347.024651] [050/133] (672s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[347.082949] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[347.087559] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[347.289870] [051/133] (672s left) kms_cursor_legacy (single-bo)
[347.416219] Starting subtest: single-bo
[347.418357] Starting dynamic subtest: pipe-A
[352.796792] Dynamic subtest pipe-A: SUCCESS (5.379s)
[352.807191] Starting dynamic subtest: pipe-B
[358.180032] Dynamic subtest pipe-B: SUCCESS (5.380s)
[358.190196] Starting dynamic subtest: pipe-C
[363.561608] Dynamic subtest pipe-C: SUCCESS (5.378s)
[363.571598] Starting dynamic subtest: pipe-D
[368.942877] Dynamic subtest pipe-D: SUCCESS (5.379s)
[368.951741] Starting dynamic subtest: all-pipes
[374.331085] Dynamic subtest all-pipes: SUCCESS (5.385s)
[374.333193] Subtest single-bo: SUCCESS (26.915s)
[374.500315] [052/133] (645s left) kms_pm_rpm (basic-pci-d3-state)
[376.041586] Starting subtest: basic-pci-d3-state
[377.516063] Subtest basic-pci-d3-state: SUCCESS (1.473s)
[377.624441] [053/133] (642s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[377.731582] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[382.179949] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.452s)
[383.393539] [054/133] (636s left) kms_pm_rpm (legacy-planes)
[385.131050] Starting subtest: legacy-planes
[385.133829] Starting dynamic subtest: plane-63
[393.724537] Dynamic subtest plane-63: SUCCESS (8.597s)
[393.736546] Starting dynamic subtest: plane-93
[401.994601] Dynamic subtest plane-93: SUCCESS (8.267s)
[402.006612] Starting dynamic subtest: plane-123
[410.420971] Dynamic subtest plane-123: SUCCESS (8.423s)
[410.431542] Starting dynamic subtest: plane-133
[418.701152] Dynamic subtest plane-133: SUCCESS (8.278s)
[418.703593] Subtest legacy-planes: SUCCESS (33.576s)
[419.084972] [055/133] (600s left) prime_self_import (basic-with_one_bo)
[419.125693] Starting subtest: basic-with_one_bo
[419.149513] Subtest basic-with_one_bo: SUCCESS (0.025s)
[419.294393] [056/133] (600s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[419.402554] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[419.406624] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[419.523579] [057/133] (600s left) kms_flip (modeset-vs-vblank-race)
[419.621106] Starting subtest: modeset-vs-vblank-race
[419.623739] Starting dynamic subtest: A-eDP1
[424.298786] Dynamic subtest A-eDP1: SUCCESS (4.678s)
[424.310978] Starting dynamic subtest: B-eDP1
[429.016920] Dynamic subtest B-eDP1: SUCCESS (4.716s)
[429.028723] Starting dynamic subtest: C-eDP1
[433.634045] Dynamic subtest C-eDP1: SUCCESS (4.615s)
[433.644674] Starting dynamic subtest: D-eDP1
[438.274034] Dynamic subtest D-eDP1: SUCCESS (4.638s)
[438.279293] Subtest modeset-vs-vblank-race: SUCCESS (18.659s)
[439.545873] [058/133] (580s left) gem_lmem_swapping (heavy-verify-random-ccs)
[439.599372] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[439.648763] [059/133] (580s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[439.750619] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[439.754753] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[439.876037] [060/133] (580s left) kms_chamelium_color (gamma)
[439.986191] Subtest gamma: SKIP (0.000s)
[440.028210] [061/133] (580s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[440.159285] Starting subtest: cursorB-vs-flipA-varying-size
[440.163709] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[440.325934] [062/133] (579s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[440.435782] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[444.907397] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.476s)
[446.064796] [063/133] (574s left) dumb_buffer (map-valid)
[446.116643] Starting subtest: map-valid
[446.118986] Subtest map-valid: SUCCESS (0.000s)
[446.253592] [064/133] (573s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[446.340391] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[446.342521] Starting dynamic subtest: pipe-A-default-mode
[446.646395] Dynamic subtest pipe-A-default-mode: SKIP (0.305s)
[446.650927] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.306s)
[447.495068] [065/133] (572s left) perf (i915-ref-count)
[447.582936] Starting subtest: i915-ref-count
[447.656548] Subtest i915-ref-count: SUCCESS (0.071s)
[447.711681] [066/133] (572s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[447.822218] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[447.826231] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[447.948353] [067/133] (572s left) gem_softpin (noreloc-interruptible)
[448.016779] Starting subtest: noreloc-interruptible
[453.406476] Subtest noreloc-interruptible: SUCCESS (5.388s)
[453.567185] [068/133] (566s left) kms_psr (fbc-psr2-primary-render)
[453.673062] Starting subtest: fbc-psr2-primary-render
[453.675386] Starting dynamic subtest: eDP-1
[453.679678] Dynamic subtest eDP-1: SKIP (0.000s)
[453.683907] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[453.768465] [069/133] (566s left) kms_lease (atomic-implicit-crtc)
[453.867195] Starting subtest: atomic-implicit-crtc
[453.869473] Starting dynamic subtest: pipe-A-eDP-1
[453.882121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[453.893285] Starting dynamic subtest: pipe-B-eDP-1
[453.904921] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[453.919746] Starting dynamic subtest: pipe-C-eDP-1
[453.930639] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[453.941608] Starting dynamic subtest: pipe-D-eDP-1
[453.952276] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[453.954154] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[454.055738] [070/133] (566s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[454.142984] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[454.513072] Starting dynamic subtest: pipe-A-eDP-1
[457.248262] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.734s)
[457.611741] Starting dynamic subtest: pipe-B-eDP-1
[460.378084] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[460.759693] Starting dynamic subtest: pipe-C-eDP-1
[463.508655] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.756s)
[463.881337] Starting dynamic subtest: pipe-D-eDP-1
[466.650267] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[466.653115] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.509s)
[467.853119] [071/133] (552s left) gem_exec_reloc (basic-wc-read-active)
[467.920646] Subtest basic-wc-read-active: SKIP (0.000s)
[468.000854] [072/133] (552s left) gem_readwrite (new-obj)
[468.068739] Subtest new-obj: SKIP (0.000s)
[468.140268] [073/133] (552s left) gem_mmap_gtt (basic-short)
[468.208122] Subtest basic-short: SKIP (0.000s)
[468.282232] [074/133] (552s left) kms_plane_multiple (tiling-yf)
[468.375350] Starting subtest: tiling-yf
[468.379724] Subtest tiling-yf: SKIP (0.000s)
[468.470019] [075/133] (552s left) kms_content_protection (dp-mst-type-0-hdcp14)
[468.626882] Starting subtest: dp-mst-type-0-hdcp14
[468.631623] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[468.790710] [076/133] (551s left) gem_ctx_shared (q-in-order)
[468.860920] Starting subtest: Q-in-order
[468.862902] Starting dynamic subtest: rcs0
[469.008259] Dynamic subtest rcs0: SUCCESS (0.149s)
[469.024984] Starting dynamic subtest: vcs0
[469.088495] Dynamic subtest vcs0: SUCCESS (0.079s)
[469.103515] Starting dynamic subtest: vcs1
[469.162168] Dynamic subtest vcs1: SUCCESS (0.073s)
[469.178960] Starting dynamic subtest: vecs0
[469.238220] Dynamic subtest vecs0: SUCCESS (0.075s)
[469.254578] Starting dynamic subtest: ccs0
[469.327716] Dynamic subtest ccs0: SUCCESS (0.088s)
[469.330234] Subtest Q-in-order: SUCCESS (0.469s)
[471.081209] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[471.084428] [077/133] (549s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[471.140934] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[471.243661] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[471.349308] [078/133] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[471.449635] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[478.120697] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.673s)
[478.285578] [079/133] (542s left) kms_big_fb (linear-8bpp-rotate-270)
[478.394413] Starting subtest: linear-8bpp-rotate-270
[478.415604] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[478.578519] [080/133] (542s left) api_intel_allocator (standalone)
[478.641336] Starting subtest: standalone
[478.653239] Subtest standalone: SUCCESS (0.015s)
[478.824961] [081/133] (542s left) core_auth (getclient-master-drop)
[478.861721] Starting subtest: getclient-master-drop
[478.878374] Subtest getclient-master-drop: SUCCESS (0.020s)
[479.016533] [082/133] (541s left) kms_psr (fbc-psr2-basic)
[479.110026] Starting subtest: fbc-psr2-basic
[479.112252] Starting dynamic subtest: eDP-1
[479.116459] Dynamic subtest eDP-1: SKIP (0.000s)
[479.120671] Subtest fbc-psr2-basic: SKIP (0.001s)
[479.208946] [083/133] (541s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[479.364275] Starting subtest: cursor-rapid-movement-32x32
[479.412743] Subtest cursor-rapid-movement-32x32: SKIP (0.043s)
[479.747384] [084/133] (541s left) gem_exec_schedule (noreorder-priority)
[479.924764] Starting subtest: noreorder-priority
[479.927207] Starting dynamic subtest: rcs0
[481.088907] Dynamic subtest rcs0: SUCCESS (1.164s)
[481.102821] Starting dynamic subtest: vcs0
[482.918518] Dynamic subtest vcs0: SUCCESS (1.826s)
[482.931173] Starting dynamic subtest: vcs1
[484.918456] Dynamic subtest vcs1: SUCCESS (1.998s)
[484.931173] Starting dynamic subtest: vecs0
[486.950470] Dynamic subtest vecs0: SUCCESS (2.029s)
[486.962650] Starting dynamic subtest: ccs0
[488.151351] Dynamic subtest ccs0: SUCCESS (1.200s)
[488.154204] Subtest noreorder-priority: SUCCESS (8.228s)
[488.364176] [085/133] (532s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[488.461093] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[488.463358] Starting dynamic subtest: pipe-A-eDP-1
[488.488679] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[488.503738] Starting dynamic subtest: pipe-B-eDP-1
[488.527340] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[488.536372] Starting dynamic subtest: pipe-C-eDP-1
[488.560040] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[488.568958] Starting dynamic subtest: pipe-D-eDP-1
[488.593215] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[488.597601] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[490.653139] [086/133] (530s left) core_auth (many-magics)
[490.718777] Starting subtest: many-magics
[491.638857] Subtest many-magics: SUCCESS (0.921s)
[491.854957] [087/133] (529s left) i915_suspend (fence-restore-tiled2untiled)
[491.915960] Starting subtest: fence-restore-tiled2untiled
[491.920577] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[492.038490] [088/133] (529s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[492.116979] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[492.119285] Starting dynamic subtest: pipe-A
[492.139369] Dynamic subtest pipe-A: SKIP (0.018s)
[492.149532] Starting dynamic subtest: pipe-B
[492.171301] Dynamic subtest pipe-B: SKIP (0.032s)
[492.180613] Starting dynamic subtest: pipe-C
[492.205264] Dynamic subtest pipe-C: SKIP (0.032s)
[492.214305] Starting dynamic subtest: pipe-D
[492.236530] Dynamic subtest pipe-D: SKIP (0.032s)
[492.240247] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.117s)
[492.378165] [089/133] (528s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[492.474543] Starting subtest: y-tiled-64bpp-rotate-0
[492.479119] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[492.594408] [090/133] (528s left) gem_ctx_persistence (saturated-hostile)
[492.654699] Starting subtest: saturated-hostile
[492.656997] Starting dynamic subtest: rcs0
[493.473285] Dynamic subtest rcs0: SUCCESS (0.818s)
[493.484095] Starting dynamic subtest: bcs0
[494.285480] Dynamic subtest bcs0: SUCCESS (0.809s)
[494.297700] Starting dynamic subtest: vcs0
[495.088335] Dynamic subtest vcs0: SUCCESS (0.801s)
[495.099892] Starting dynamic subtest: vcs1
[495.916232] Dynamic subtest vcs1: SUCCESS (0.826s)
[495.928068] Starting dynamic subtest: vecs0
[496.746623] Dynamic subtest vecs0: SUCCESS (0.828s)
[496.758664] Starting dynamic subtest: ccs0
[497.613452] Dynamic subtest ccs0: SUCCESS (0.865s)
[497.615854] Subtest saturated-hostile: SUCCESS (4.959s)
[497.720759] [091/133] (523s left) kms_prop_blob (invalid-get-prop)
[497.776897] Starting subtest: invalid-get-prop
[497.779412] Subtest invalid-get-prop: SUCCESS (0.000s)
[497.909514] [092/133] (523s left) gem_mmap_gtt (basic-write)
[497.961887] Subtest basic-write: SKIP (0.000s)
[498.029340] [093/133] (523s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[498.145255] Starting subtest: cursorA-vs-flipA-varying-size
[509.269125] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.124s)
[510.172141] [094/133] (511s left) gem_linear_blits (interruptible)
[510.560932] Starting subtest: interruptible
[514.873116] Subtest interruptible: SUCCESS (4.313s)
[515.053982] [095/133] (506s left) gem_exec_params (sol-reset-invalid)
[515.149442] Starting subtest: sol-reset-invalid
[515.154801] Subtest sol-reset-invalid: SUCCESS (0.004s)
[517.012663] [096/133] (504s left) kms_color_pipeline (plane-lut1d)
[517.117089] Starting subtest: plane-lut1d
[517.133735] Starting dynamic subtest: pipe-A-eDP-1
[517.866066] Dynamic subtest pipe-A-eDP-1: FAIL (0.347s)
[518.532071] Starting dynamic subtest: pipe-B-eDP-1
[519.340060] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[519.860583] Starting dynamic subtest: pipe-C-eDP-1
[520.711888] Dynamic subtest pipe-C-eDP-1: FAIL (0.269s)
[521.188774] Starting dynamic subtest: pipe-D-eDP-1
[522.052685] Dynamic subtest pipe-D-eDP-1: FAIL (0.291s)
[522.054717] Subtest plane-lut1d: FAIL (4.634s)
[522.593707] [097/133] (498s left) gem_wait (busy)
[522.670281] Starting subtest: busy
[522.672627] Starting dynamic subtest: all-engines
[523.928039] Dynamic subtest all-engines: SUCCESS (1.256s)
[523.940578] Starting dynamic subtest: rcs0
[524.471474] Dynamic subtest rcs0: SUCCESS (0.542s)
[524.482844] Starting dynamic subtest: bcs0
[525.010463] Dynamic subtest bcs0: SUCCESS (0.538s)
[525.021217] Starting dynamic subtest: vcs0
[526.933903] Dynamic subtest vcs0: SUCCESS (1.922s)
[526.946060] Starting dynamic subtest: vcs1
[528.919074] Dynamic subtest vcs1: SUCCESS (1.981s)
[528.931067] Starting dynamic subtest: vecs0
[530.902971] Dynamic subtest vecs0: SUCCESS (1.981s)
[530.915035] Starting dynamic subtest: ccs0
[531.445243] Dynamic subtest ccs0: SUCCESS (0.541s)
[531.447777] Subtest busy: SUCCESS (8.775s)
[531.666383] [098/133] (489s left) sriov_basic (enable-vfs-autoprobe-on)
[531.722882] Starting subtest: enable-vfs-autoprobe-on
[531.724994] Starting dynamic subtest: numvfs-1
[531.798668] Dynamic subtest numvfs-1: FAIL (0.005s)
[531.814461] Starting dynamic subtest: numvfs-2
[531.889488] Dynamic subtest numvfs-2: FAIL (0.003s)
[531.901513] Starting dynamic subtest: numvfs-3
[531.974571] Dynamic subtest numvfs-3: FAIL (0.003s)
[531.985451] Starting dynamic subtest: numvfs-4
[532.057833] Dynamic subtest numvfs-4: FAIL (0.003s)
[532.069057] Starting dynamic subtest: numvfs-5
[532.140683] Dynamic subtest numvfs-5: FAIL (0.004s)
[532.151585] Starting dynamic subtest: numvfs-6
[532.224214] Dynamic subtest numvfs-6: FAIL (0.003s)
[532.235178] Starting dynamic subtest: numvfs-7
[532.309307] Dynamic subtest numvfs-7: FAIL (0.004s)
[532.320778] Starting dynamic subtest: numvfs-random
[532.390764] Dynamic subtest numvfs-random: FAIL (0.003s)
[532.400382] Starting dynamic subtest: numvfs-all
[532.469260] Dynamic subtest numvfs-all: FAIL (0.522s)
[532.471592] Subtest enable-vfs-autoprobe-on: FAIL (0.559s)
[532.509076] [099/133] (489s left) kms_chamelium_frames (vga-frame-dump)
[532.894676] Subtest vga-frame-dump: SKIP (0.000s)
[533.707315] [100/133] (488s left) gem_eio (throttle)
[533.903551] Starting subtest: throttle
[534.181392] Subtest throttle: SUCCESS (0.276s)
[534.357247] [101/133] (487s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[534.481998] Starting subtest: psr-abgr161616f-draw-mmap-wc
[534.485941] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[534.616472] [102/133] (487s left) gem_softpin (allocator-nopin)
[534.683265] Starting subtest: allocator-nopin
[534.791909] Subtest allocator-nopin: SUCCESS (0.107s)
[534.952925] [103/133] (486s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[535.063413] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[535.754245] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[535.944716] [104/133] (485s left) kms_flip (busy-flip)
[536.047830] Starting subtest: busy-flip
[536.050133] Starting dynamic subtest: A-eDP1
[537.720792] Dynamic subtest A-eDP1: SUCCESS (1.674s)
[537.732985] Starting dynamic subtest: B-eDP1
[539.446349] Dynamic subtest B-eDP1: SUCCESS (1.723s)
[539.459196] Starting dynamic subtest: C-eDP1
[541.086503] Dynamic subtest C-eDP1: SUCCESS (1.639s)
[541.100112] Starting dynamic subtest: D-eDP1
[542.814384] Dynamic subtest D-eDP1: SUCCESS (1.724s)
[542.816750] Subtest busy-flip: SUCCESS (6.772s)
[544.090076] [105/133] (477s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[544.194502] Starting subtest: x-tiled-16bpp-rotate-270
[544.215638] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s)
[544.376255] [106/133] (477s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[544.487294] Starting subtest: fbcpsr-abgr161616f-draw-render
[544.491371] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[544.626926] [107/133] (477s left) kms_getfb (getfb2-accept-nv12)
[544.720181] Starting subtest: getfb2-accept-nv12
[544.722456] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[544.861053] [108/133] (477s left) gem_ctx_exec (basic-nohangcheck)
[544.916598] Starting subtest: basic-nohangcheck
[545.170048] Subtest basic-nohangcheck: SUCCESS (0.254s)
[545.317791] [109/133] (476s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[545.444642] Starting subtest: short-flip-before-cursor-atomic-transitions
[546.393597] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.947s)
[547.229315] [110/133] (474s left) kms_cursor_crc (cursor-offscreen-256x256)
[547.479237] Starting subtest: cursor-offscreen-256x256
[547.484651] Starting dynamic subtest: pipe-A-eDP-1
[549.415207] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[549.445889] Starting dynamic subtest: pipe-D-eDP-1
[552.025787] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.587s)
[552.027687] Subtest cursor-offscreen-256x256: SUCCESS (4.544s)
[552.905952] [111/133] (469s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[553.009258] Starting subtest: 4-tiled-8bpp-rotate-0
[554.244192] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.234s)
[554.424755] [112/133] (467s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[554.485086] Subtest writes-after-reads: SKIP (0.000s)
[554.565546] [113/133] (467s left) kms_frontbuffer_tracking (psr-slowdraw)
[554.661014] Starting subtest: psr-slowdraw
[579.941075] Subtest psr-slowdraw: SUCCESS (25.280s)
[580.090744] [114/133] (442s left) i915_pm_rc6_residency (rc6-idle)
[580.151781] Starting subtest: rc6-idle
[580.181756] Starting dynamic subtest: gt0-rcs0
[604.467311] Dynamic subtest gt0-rcs0: SUCCESS (24.285s)
[604.476754] Starting dynamic subtest: gt0-bcs0
[628.805490] Dynamic subtest gt0-bcs0: SUCCESS (24.335s)
[628.817131] Starting dynamic subtest: gt0-ccs0
[653.076960] Dynamic subtest gt0-ccs0: SUCCESS (24.269s)
[653.089044] Starting dynamic subtest: gt1-vcs0
[659.251208] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[659.263885] Starting dynamic subtest: gt1-vecs0
[665.423482] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[665.426237] Subtest rc6-idle: SUCCESS (85.271s)
[665.532633] [115/133] (356s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[665.645101] Starting subtest: fbc-modesetfrombusy
[669.437884] Subtest fbc-modesetfrombusy: SUCCESS (3.796s)
[670.636088] [116/133] (351s left) kms_psr (psr-cursor-render)
[670.733612] Starting subtest: psr-cursor-render
[670.735983] Starting dynamic subtest: eDP-1
[672.492507] Dynamic subtest eDP-1: SUCCESS (1.758s)
[672.494925] Subtest psr-cursor-render: SUCCESS (1.759s)
[673.392972] [117/133] (349s left) gem_exec_parallel (engines)
[673.464345] Starting subtest: engines
[673.466807] Starting dynamic subtest: basic
[674.954441] Dynamic subtest basic: SUCCESS (1.489s)
[674.967443] Starting dynamic subtest: contexts
[679.390705] Dynamic subtest contexts: SUCCESS (4.434s)
[679.401558] Starting dynamic subtest: fds
[683.207050] Dynamic subtest fds: SUCCESS (3.814s)
[683.218181] Starting dynamic subtest: userptr
[684.919602] Dynamic subtest userptr: SUCCESS (1.710s)
[684.922090] Subtest engines: SUCCESS (11.454s)
[685.135592] [118/133] (337s left) prime_busy (after)
[685.208167] Starting subtest: after
[685.213268] Starting dynamic subtest: rcs0
[685.252401] Dynamic subtest rcs0: SUCCESS (0.040s)
[685.264529] Starting dynamic subtest: bcs0
[685.311094] Dynamic subtest bcs0: SUCCESS (0.058s)
[685.321779] Starting dynamic subtest: vcs0
[685.352605] Dynamic subtest vcs0: SUCCESS (0.041s)
[685.362231] Starting dynamic subtest: vcs1
[685.394051] Dynamic subtest vcs1: SUCCESS (0.041s)
[685.403750] Starting dynamic subtest: vecs0
[685.436291] Dynamic subtest vecs0: SUCCESS (0.041s)
[685.448088] Starting dynamic subtest: ccs0
[685.479173] Dynamic subtest ccs0: SUCCESS (0.042s)
[685.587158] Subtest after: SUCCESS (0.378s)
[685.688951] [119/133] (336s left) gem_partial_pwrite_pread (write-display)
[685.741748] Subtest write-display: SKIP (0.000s)
[685.830454] [120/133] (336s left) gem_tiled_blits (basic)
[685.886618] Subtest basic: SKIP (0.000s)
[685.955908] [121/133] (336s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[686.069643] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[694.738881] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.673s)
[694.878958] [122/133] (327s left) sysfs_defaults (readonly)
[694.955051] Starting subtest: readonly
[694.957290] Starting dynamic subtest: vecs0
[694.959570] Dynamic subtest vecs0: SUCCESS (0.000s)
[694.969635] Starting dynamic subtest: ccs0
[694.971687] Dynamic subtest ccs0: SUCCESS (0.000s)
[694.981121] Starting dynamic subtest: vcs0
[694.983230] Dynamic subtest vcs0: SUCCESS (0.000s)
[694.992865] Starting dynamic subtest: bcs0
[694.995022] Dynamic subtest bcs0: SUCCESS (0.000s)
[695.004595] Starting dynamic subtest: rcs0
[695.006710] Dynamic subtest rcs0: SUCCESS (0.000s)
[695.016495] Starting dynamic subtest: vcs1
[695.018360] Dynamic subtest vcs1: SUCCESS (0.000s)
[695.020155] Subtest readonly: SUCCESS (0.006s)
[695.094015] [123/133] (327s left) kms_dsc (dsc-with-formats)
[695.190848] Starting subtest: dsc-with-formats
[695.228694] Subtest dsc-with-formats: SKIP (0.001s)
[695.289183] [124/133] (327s left) prime_mmap (test_reprime)
[695.348925] Starting subtest: test_reprime
[695.350768] Starting dynamic subtest: test_reprime-smem
[695.381894] Dynamic subtest test_reprime-smem: SUCCESS (0.035s)
[695.384381] Subtest test_reprime: SUCCESS (0.036s)
[695.544815] [125/133] (327s left) gem_exec_params (rsvd2-dirt)
[695.615372] Starting subtest: rsvd2-dirt
[695.619985] Subtest rsvd2-dirt: SKIP (0.000s)
[695.743987] [126/133] (327s left) kms_lease (lessee-list)
[695.838577] Starting subtest: lessee-list
[695.840476] Starting dynamic subtest: pipe-A-eDP-1
[695.842209] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[695.851884] Starting dynamic subtest: pipe-B-eDP-1
[695.853638] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[695.862954] Starting dynamic subtest: pipe-C-eDP-1
[695.864730] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[695.874072] Starting dynamic subtest: pipe-D-eDP-1
[695.875875] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[695.877681] Subtest lessee-list: SUCCESS (0.010s)
[695.984420] [127/133] (326s left) kms_vrr (flip-dpms)
[696.088869] Starting subtest: flip-dpms
[696.094151] Subtest flip-dpms: SKIP (0.000s)
[696.184164] [128/133] (326s left) kms_frontbuffer_tracking (fbc-1p-rte)
[696.281989] Starting subtest: fbc-1p-rte
[701.753224] Subtest fbc-1p-rte: SUCCESS (5.474s)
[702.997075] [129/133] (319s left) gen9_exec_parse (batch-zero-length)
[703.063768] Subtest batch-zero-length: SKIP (0.000s)
[703.156919] [130/133] (319s left) prime_mmap (test_aperture_limit)
[703.219067] Starting subtest: test_aperture_limit
[703.220888] Starting dynamic subtest: test_aperture_limit-smem
[703.227621] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[703.231629] Subtest test_aperture_limit: SKIP (0.008s)
[703.370205] [131/133] (319s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[703.477464] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[703.481735] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[703.610719] [132/133] (319s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[703.710250] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[703.714159] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[703.856820] [133/133] (319s left) gem_exec_fence (long-history)
[704.337836] Starting subtest: long-history
[711.722761] Subtest long-history: SUCCESS (7.386s)
[712.187061] 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.