[57.790509] Initializing watchdogs
[57.790558]   /dev/watchdog0
[57.807286] [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.812092] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.814498] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.817966] [001/133] (960s left) kms_psr (psr-cursor-render)
[57.929915] Starting subtest: psr-cursor-render
[57.932318] Starting dynamic subtest: eDP-1
[59.621224] Dynamic subtest eDP-1: SUCCESS (1.682s)
[59.623618] Subtest psr-cursor-render: SUCCESS (1.682s)
[60.501697] [002/133] (957s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[60.587698] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[60.677944] [003/133] (957s left) kms_chamelium_audio (hdmi-audio)
[61.066211] Subtest hdmi-audio: SKIP (0.000s)
[61.907626] [004/133] (956s left) gem_lmem_swapping (basic)
[61.952121] Subtest basic: SKIP (0.000s)
[61.989677] [005/133] (956s left) kms_sequence (get-busy)
[62.081215] Starting subtest: get-busy
[62.083524] Starting dynamic subtest: pipe-A-eDP-1
[64.023023] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[64.031685] Starting dynamic subtest: pipe-B-eDP-1
[66.629228] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.601s)
[66.637058] Starting dynamic subtest: pipe-C-eDP-1
[69.247650] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.614s)
[69.256479] Starting dynamic subtest: pipe-D-eDP-1
[71.878979] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.626s)
[71.881206] Subtest get-busy: SUCCESS (9.780s)
[72.687958] [006/133] (945s left) gem_mmap_offset (mmap-unmap)
[72.746810] Starting subtest: mmap-unmap
[72.749154] Starting dynamic subtest: smem0
[94.961343] Dynamic subtest smem0: SUCCESS (22.204s)
[94.963739] Subtest mmap-unmap: SUCCESS (22.205s)
[95.089355] [007/133] (923s left) gem_mmap (basic)
[95.146228] Subtest basic: SKIP (0.000s)
[95.200423] [008/133] (923s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[95.305065] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[95.307518] Starting dynamic subtest: pipe-A-eDP-1
[95.331400] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[95.340259] Starting dynamic subtest: pipe-B-eDP-1
[95.362029] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[95.368354] Starting dynamic subtest: pipe-C-eDP-1
[95.390015] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[95.396292] Starting dynamic subtest: pipe-D-eDP-1
[95.418308] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[95.422676] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[97.551821] [009/133] (921s left) gem_ctx_bad_destroy (invalid-ctx)
[97.606248] Starting subtest: invalid-ctx
[97.608512] Subtest invalid-ctx: SUCCESS (0.000s)
[97.702827] [010/133] (920s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[97.792471] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[104.593640] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.801s)
[104.740418] [011/133] (913s left) kms_flip (basic-flip-vs-modeset)
[104.843476] Starting subtest: basic-flip-vs-modeset
[104.845701] Starting dynamic subtest: A-eDP1
[107.483411] Dynamic subtest A-eDP1: SUCCESS (2.640s)
[107.493178] Starting dynamic subtest: B-eDP1
[109.660362] Dynamic subtest B-eDP1: SUCCESS (2.176s)
[109.668442] Starting dynamic subtest: C-eDP1
[111.827568] Dynamic subtest C-eDP1: SUCCESS (2.166s)
[111.839452] Starting dynamic subtest: D-eDP1
[113.893547] Dynamic subtest D-eDP1: SUCCESS (2.066s)
[113.896214] Subtest basic-flip-vs-modeset: SUCCESS (9.054s)
[114.700858] [012/133] (904s left) kms_vblank (wait-forked)
[114.793063] Starting subtest: wait-forked
[114.795304] Starting dynamic subtest: pipe-A-eDP-1
[116.603337] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.809s)
[116.618523] Starting dynamic subtest: pipe-D-eDP-1
[119.093662] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.488s)
[119.096087] Subtest wait-forked: SUCCESS (4.301s)
[119.970470] [013/133] (898s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[120.078643] Starting subtest: yf-tiled-addfb-size-offset-overflow
[120.082652] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[120.162669] [014/133] (898s left) syncobj_wait (wait-all-complex)
[120.218399] Starting subtest: wait-all-complex
[120.432424] Subtest wait-all-complex: SUCCESS (0.214s)
[120.512079] [015/133] (898s left) gem_wait (busy)
[120.570918] Starting subtest: busy
[120.573506] Starting dynamic subtest: all-engines
[121.940064] Dynamic subtest all-engines: SUCCESS (1.367s)
[121.950678] Starting dynamic subtest: rcs0
[122.482638] Dynamic subtest rcs0: SUCCESS (0.542s)
[122.492200] Starting dynamic subtest: bcs0
[123.022239] Dynamic subtest bcs0: SUCCESS (0.539s)
[123.032210] Starting dynamic subtest: vcs0
[124.884456] Dynamic subtest vcs0: SUCCESS (1.860s)
[124.894617] Starting dynamic subtest: vcs1
[126.932720] Dynamic subtest vcs1: SUCCESS (2.047s)
[126.942529] Starting dynamic subtest: vecs0
[128.918922] Dynamic subtest vecs0: SUCCESS (1.984s)
[128.929116] Starting dynamic subtest: ccs0
[129.459367] Dynamic subtest ccs0: SUCCESS (0.541s)
[129.461812] Subtest busy: SUCCESS (8.887s)
[129.648872] [016/133] (889s left) syncobj_timeline (transfer-timeline-point)
[129.701859] Starting subtest: transfer-timeline-point
[129.704187] Subtest transfer-timeline-point: SUCCESS (0.000s)
[129.801520] [017/133] (889s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[129.907517] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[136.660494] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.756s)
[136.790462] [018/133] (882s left) kms_content_protection (uevent)
[136.936045] Starting subtest: uevent
[136.940833] Subtest uevent: SKIP (0.000s)
[137.046161] [019/133] (881s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[137.139129] Starting subtest: 4-tiled-32bpp-rotate-180
[138.617540] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.479s)
[138.758851] [020/133] (880s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[138.868301] Starting subtest: cursor-vs-flip-atomic
[168.144812] Subtest cursor-vs-flip-atomic: SUCCESS (29.273s)
[168.956548] [021/133] (850s left) gem_userptr_blits (create-destroy-sync)
[169.026625] Starting subtest: create-destroy-sync
[174.039269] Subtest create-destroy-sync: SUCCESS (5.012s)
[174.174464] [022/133] (844s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[174.274908] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[174.277252] Starting dynamic subtest: pipe-A-eDP-1
[174.285981] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[174.296364] Starting dynamic subtest: pipe-B-eDP-1
[174.305258] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[174.312109] Starting dynamic subtest: pipe-C-eDP-1
[174.320408] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[174.327063] Starting dynamic subtest: pipe-D-eDP-1
[174.335270] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[174.339412] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[176.444933] [023/133] (842s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[176.502374] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[176.504409] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[176.585680] [024/133] (842s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[176.682472] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[183.215977] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.536s)
[183.340070] [025/133] (835s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[183.458222] Starting subtest: flip-vs-cursor-atomic-transitions
[190.930458] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.471s)
[191.799155] [026/133] (827s left) prime_mmap (test_aperture_limit)
[191.859162] Starting subtest: test_aperture_limit
[191.861414] Starting dynamic subtest: test_aperture_limit-smem
[191.868638] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[191.872854] Subtest test_aperture_limit: SKIP (0.008s)
[191.933799] [027/133] (827s left) gem_ctx_param (set-priority-range)
[191.986714] Starting subtest: set-priority-range
[191.999892] Subtest set-priority-range: SUCCESS (0.013s)
[192.096617] [028/133] (827s left) perf_pmu (multi-client)
[192.144860] Starting subtest: multi-client
[192.146817] Starting dynamic subtest: rcs0
[193.204578] Dynamic subtest rcs0: SUCCESS (1.059s)
[193.215167] Starting dynamic subtest: bcs0
[194.254659] Dynamic subtest bcs0: SUCCESS (1.048s)
[194.265185] Starting dynamic subtest: vcs0
[195.306105] Dynamic subtest vcs0: SUCCESS (1.049s)
[195.316892] Starting dynamic subtest: vcs1
[196.943103] Dynamic subtest vcs1: SUCCESS (1.635s)
[196.953823] Starting dynamic subtest: vecs0
[198.924279] Dynamic subtest vecs0: SUCCESS (1.979s)
[198.935074] Starting dynamic subtest: ccs0
[200.909754] Dynamic subtest ccs0: SUCCESS (1.984s)
[200.912318] Subtest multi-client: SUCCESS (8.766s)
[201.026165] [029/133] (818s left) kms_hdr (static-toggle-suspend)
[201.123935] Starting subtest: static-toggle-suspend
[201.130174] Subtest static-toggle-suspend: SKIP (0.000s)
[201.189895] [030/133] (818s left) kms_cursor_edge_walk (256x256-right-edge)
[201.280440] Starting subtest: 256x256-right-edge
[201.282820] Starting dynamic subtest: pipe-A-eDP-1
[204.763762] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.482s)
[204.775615] Starting dynamic subtest: pipe-D-eDP-1
[207.876417] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.109s)
[207.878420] Subtest 256x256-right-edge: SUCCESS (6.594s)
[208.696280] [031/133] (810s left) i915_pm_rpm (sysfs-read)
[210.233050] Starting subtest: sysfs-read
[211.386873] Subtest sysfs-read: SUCCESS (1.151s)
[211.763820] [032/133] (807s left) gem_linear_blits (normal)
[212.071521] Starting subtest: normal
[215.715796] Subtest normal: SUCCESS (3.643s)
[215.846755] [033/133] (803s left) kms_setmode (invalid-clone-single-crtc-stealing)
[215.931359] Starting subtest: invalid-clone-single-crtc-stealing
[215.938291] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[216.038240] [034/133] (803s left) gem_exec_schedule (independent)
[216.117176] Starting subtest: independent
[216.119084] Starting dynamic subtest: rcs0
[217.878981] Dynamic subtest rcs0: SUCCESS (1.768s)
[217.889325] Starting dynamic subtest: vcs0
[219.935746] Dynamic subtest vcs0: SUCCESS (2.054s)
[219.946580] Starting dynamic subtest: vcs1
[221.909305] Dynamic subtest vcs1: SUCCESS (1.973s)
[221.920292] Starting dynamic subtest: vecs0
[223.904402] Dynamic subtest vecs0: SUCCESS (1.993s)
[223.915673] Starting dynamic subtest: ccs0
[225.878446] Dynamic subtest ccs0: SUCCESS (1.972s)
[225.881084] Subtest independent: SUCCESS (9.769s)
[226.174965] [035/133] (793s left) dumb_buffer (create-valid-dumb)
[226.230024] Starting subtest: create-valid-dumb
[226.232324] Subtest create-valid-dumb: SUCCESS (0.000s)
[226.329342] [036/133] (793s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[226.723142] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[227.570814] [037/133] (792s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[227.671626] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[228.485719] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.816s)
[228.657210] [038/133] (791s left) kms_getfb (getfb-addfb-different-handles)
[228.749806] Starting subtest: getfb-addfb-different-handles
[228.752022] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[228.835901] [039/133] (790s left) kms_plane_scaling (planes-upscale-factor-0-25)
[228.931679] Starting subtest: planes-upscale-factor-0-25
[228.933877] Starting dynamic subtest: pipe-A
[228.992064] Dynamic subtest pipe-A: SUCCESS (0.062s)
[229.000983] Starting dynamic subtest: pipe-B
[230.106622] Dynamic subtest pipe-B: SUCCESS (1.113s)
[230.117384] Starting dynamic subtest: pipe-C
[231.216904] Dynamic subtest pipe-C: SUCCESS (1.109s)
[231.226081] Starting dynamic subtest: pipe-D
[232.344117] Dynamic subtest pipe-D: SUCCESS (1.127s)
[232.346516] Subtest planes-upscale-factor-0-25: SUCCESS (3.414s)
[233.503828] [040/133] (786s left) kms_lease (lease-get)
[233.605196] Starting subtest: lease-get
[233.607702] Starting dynamic subtest: pipe-A-eDP-1
[233.610304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[233.620708] Starting dynamic subtest: pipe-B-eDP-1
[233.622816] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[233.631321] Starting dynamic subtest: pipe-C-eDP-1
[233.633426] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[233.640804] Starting dynamic subtest: pipe-D-eDP-1
[233.642989] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[233.645152] Subtest lease-get: SUCCESS (0.008s)
[233.721615] [041/133] (786s left) kms_addfb_basic (size-max)
[233.820427] Starting subtest: size-max
[233.822355] Subtest size-max: SUCCESS (0.000s)
[233.907674] [042/133] (785s left) gem_exec_schedule (u-semaphore-user)
[233.969941] Starting subtest: u-semaphore-user
[234.018706] Subtest u-semaphore-user: SUCCESS (0.056s)
[235.962300] [043/133] (783s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[236.066646] Starting subtest: fbc-rgb101010-draw-mmap-wc
[240.625264] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.562s)
[241.733605] [044/133] (778s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[241.828891] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[241.832810] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[241.897660] [045/133] (778s left) perf (blocking-parameterized)
[242.044374] Starting subtest: blocking-parameterized
[262.070780] Subtest blocking-parameterized: SUCCESS (20.023s)
[262.118165] [046/133] (757s left) gem_lmem_swapping (parallel-random-verify)
[262.161467] Subtest parallel-random-verify: SKIP (0.000s)
[262.206722] [047/133] (757s left) gem_create (hog-create)
[262.273972] Starting subtest: hog-create
[262.276803] Starting dynamic subtest: smem0
[295.892264] Dynamic subtest smem0: SUCCESS (33.615s)
[295.894794] Subtest hog-create: SUCCESS (33.617s)
[296.081150] [048/133] (724s left) api_intel_bb (intel-bb-blit-x)
[296.136679] Starting subtest: intel-bb-blit-x
[299.905543] Subtest intel-bb-blit-x: SUCCESS (3.769s)
[300.028845] [049/133] (720s left) kms_pipe_crc_basic (suspend-read-crc)
[300.136945] Starting subtest: suspend-read-crc
[300.139148] Starting dynamic subtest: pipe-A-eDP-1
[318.012702] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.643s)
[318.022710] Starting dynamic subtest: pipe-B-eDP-1
[335.995122] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.088s)
[336.005117] Starting dynamic subtest: pipe-C-eDP-1
[353.969168] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.986s)
[353.979878] Starting dynamic subtest: pipe-D-eDP-1
[371.986935] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.076s)
[371.989306] Subtest suspend-read-crc: SUCCESS (11.798s)
[372.828033] [050/133] (647s left) gem_exec_whisper (basic-fds-priority-all)
[372.888299] Starting subtest: basic-fds-priority-all
[395.252896] Subtest basic-fds-priority-all: SUCCESS (22.207s)
[395.433118] [051/133] (624s left) gem_exec_balancer (full)
[395.507195] Starting subtest: full
[400.621640] Subtest full: SUCCESS (5.109s)
[400.948509] [052/133] (619s left) kms_dp_link_training (uhbr-sst)
[401.049764] Starting subtest: uhbr-sst
[401.058288] Subtest uhbr-sst: SKIP (0.000s)
[401.119427] [053/133] (619s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[401.219022] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[401.222953] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[401.331155] [054/133] (619s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[401.426015] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[401.430423] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[402.520119] [055/133] (617s left) gem_exec_flush (basic-wb-pro-default)
[402.583438] Starting subtest: basic-wb-pro-default
[408.051006] Subtest basic-wb-pro-default: SUCCESS (5.470s)
[408.238734] [056/133] (612s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[408.354682] Starting subtest: flip-vs-cursor-toggle
[416.805642] Subtest flip-vs-cursor-toggle: SUCCESS (8.450s)
[417.641525] [057/133] (602s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[417.745475] Starting subtest: fbc-pr-cursor-mmap-cpu
[417.749975] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[417.818763] [058/133] (602s left) drm_read (empty-block)
[417.964784] Starting subtest: empty-block
[418.965776] Subtest empty-block: SUCCESS (1.000s)
[419.100181] [059/133] (601s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[419.191259] Starting subtest: fbc-pr-sprite-mmap-gtt
[419.195410] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[419.258186] [060/133] (601s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[419.354277] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[423.321703] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.969s)
[424.464385] [061/133] (596s left) vgem_basic (bad-handle)
[424.618331] Starting subtest: bad-handle
[424.620508] Subtest bad-handle: SUCCESS (0.000s)
[424.706291] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[424.711323] [062/133] (595s left) gem_exec_params (mmapped)
[424.767061] Starting subtest: mmapped
[424.771644] Subtest mmapped: SUCCESS (0.003s)
[424.880602] [063/133] (595s left) kms_pm_dc (dc6-psr)
[425.965932] Starting subtest: dc6-psr
[428.847188] Subtest dc6-psr: SUCCESS (2.879s)
[429.681919] [064/133] (591s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[429.737594] Starting subtest: framebuffer-vs-set-tiling
[429.742674] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[429.877314] [065/133] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[429.975837] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[429.980005] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[430.067051] [066/133] (590s left) gem_softpin (evict-prime-sanity-check)
[430.133656] Starting subtest: evict-prime-sanity-check
[430.136022] Starting dynamic subtest: rcs0
[431.286600] Dynamic subtest rcs0: SUCCESS (1.152s)
[431.298270] Starting dynamic subtest: bcs0
[432.401688] Dynamic subtest bcs0: SUCCESS (1.114s)
[432.413899] Starting dynamic subtest: vcs0
[433.668255] Dynamic subtest vcs0: SUCCESS (1.263s)
[433.680182] Starting dynamic subtest: vcs1
[436.754695] Dynamic subtest vcs1: SUCCESS (3.083s)
[436.769065] Starting dynamic subtest: vecs0
[438.681978] Dynamic subtest vecs0: SUCCESS (1.924s)
[438.693898] Starting dynamic subtest: ccs0
[439.802609] Dynamic subtest ccs0: SUCCESS (1.119s)
[439.812949] Starting dynamic subtest: all
[440.922396] Dynamic subtest all: SUCCESS (1.117s)
[440.924694] Subtest evict-prime-sanity-check: SUCCESS (10.786s)
[441.002254] [067/133] (579s left) kms_cursor_legacy (torture-move)
[441.124046] Starting subtest: torture-move
[441.126304] Starting dynamic subtest: pipe-A
[447.565635] Dynamic subtest pipe-A: SUCCESS (6.435s)
[447.581644] Starting dynamic subtest: pipe-B
[454.551985] Dynamic subtest pipe-B: SUCCESS (6.982s)
[454.570611] Starting dynamic subtest: pipe-C
[461.122694] Dynamic subtest pipe-C: SUCCESS (6.564s)
[461.132044] Starting dynamic subtest: pipe-D
[468.120678] Dynamic subtest pipe-D: SUCCESS (6.998s)
[468.130635] Starting dynamic subtest: all-pipes
[475.057568] Dynamic subtest all-pipes: SUCCESS (6.934s)
[475.060809] Subtest torture-move: SUCCESS (33.924s)
[475.214960] [068/133] (545s left) kms_flip (plain-flip-fb-recreate-interruptible)
[475.322113] Starting subtest: plain-flip-fb-recreate-interruptible
[475.326074] Starting dynamic subtest: A-eDP1
[484.189501] Dynamic subtest A-eDP1: SUCCESS (8.867s)
[484.201958] Starting dynamic subtest: B-eDP1
[492.999160] Dynamic subtest B-eDP1: SUCCESS (8.807s)
[493.010022] Starting dynamic subtest: C-eDP1
[501.825557] Dynamic subtest C-eDP1: SUCCESS (8.824s)
[501.834937] Starting dynamic subtest: D-eDP1
[510.666781] Dynamic subtest D-eDP1: SUCCESS (8.838s)
[510.671113] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.348s)
[511.852545] [069/133] (509s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[511.951282] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[511.955433] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[512.036243] [070/133] (508s left) perf_pmu (all-busy-check-all)
[512.076937] Starting subtest: all-busy-check-all
[513.755892] Subtest all-busy-check-all: SUCCESS (1.677s)
[513.866583] [071/133] (507s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[513.964733] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[513.991162] Starting dynamic subtest: pipe-A-plane-0
[514.413067] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[514.424348] Starting dynamic subtest: pipe-A-plane-3
[514.668634] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[514.678636] Starting dynamic subtest: pipe-A-plane-5
[514.682699] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[515.725023] Starting dynamic subtest: pipe-B-plane-0
[516.162582] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[516.174592] Starting dynamic subtest: pipe-B-plane-3
[516.428538] Dynamic subtest pipe-B-plane-3: SUCCESS (0.265s)
[516.438580] Starting dynamic subtest: pipe-B-plane-5
[516.443251] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[516.737900] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.773s)
[517.592196] [072/133] (503s left) gem_ctx_param (invalid-get-ringsize)
[517.644798] Starting subtest: invalid-get-ringsize
[517.647307] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[517.765599] [073/133] (503s left) gem_eio (in-flight-contexts-1us)
[517.982530] Starting subtest: in-flight-contexts-1us
[529.788033] Subtest in-flight-contexts-1us: SUCCESS (11.803s)
[529.964383] [074/133] (491s left) kms_frontbuffer_tracking (fbc-1p-rte)
[530.051502] Starting subtest: fbc-1p-rte
[535.475534] Subtest fbc-1p-rte: SUCCESS (5.427s)
[536.597128] [075/133] (484s left) gem_pxp (reject-modify-context-protection-off-2)
[536.728612] Starting subtest: reject-modify-context-protection-off-2
[536.731206] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[536.846279] [076/133] (484s left) drm_read (short-buffer-block)
[536.996982] Starting subtest: short-buffer-block
[536.999277] Subtest short-buffer-block: SUCCESS (0.000s)
[537.136012] [077/133] (484s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[537.221674] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[537.223937] Starting dynamic subtest: pipe-A-eDP-1
[537.247407] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[537.257951] Starting dynamic subtest: pipe-B-eDP-1
[537.280130] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[537.289679] Starting dynamic subtest: pipe-C-eDP-1
[537.312990] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[537.323608] Starting dynamic subtest: pipe-D-eDP-1
[537.346664] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[537.350483] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[539.476079] [078/133] (481s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[539.576672] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[539.578922] Starting dynamic subtest: pipe-A
[539.983045] Dynamic subtest pipe-A: SUCCESS (0.408s)
[539.995429] Starting dynamic subtest: pipe-B
[541.371920] Dynamic subtest pipe-B: SUCCESS (1.385s)
[541.383104] Starting dynamic subtest: pipe-C
[542.826500] Dynamic subtest pipe-C: SUCCESS (1.453s)
[542.836398] Starting dynamic subtest: pipe-D
[544.266498] Dynamic subtest pipe-D: SUCCESS (1.439s)
[544.268872] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.692s)
[545.419046] [079/133] (475s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[545.514685] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[545.519099] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[545.599580] [080/133] (475s left) gem_exec_alignment (pi)
[545.669455] Starting subtest: pi
[596.504328] Subtest pi: SUCCESS (50.816s)
[597.506346] [081/133] (423s left) kms_cursor_crc (cursor-onscreen-256x256)
[597.798823] Starting subtest: cursor-onscreen-256x256
[597.801169] Starting dynamic subtest: pipe-A-eDP-1
[600.007602] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.206s)
[600.035195] Starting dynamic subtest: pipe-D-eDP-1
[602.817320] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.788s)
[602.819330] Subtest cursor-onscreen-256x256: SUCCESS (5.020s)
[603.697523] [082/133] (417s left) syncobj_wait (single-wait-for-submit-signaled)
[603.772121] Starting subtest: single-wait-for-submit-signaled
[603.774562] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[603.884100] [083/133] (417s left) kms_psr (psr2-sprite-blt)
[603.973124] Starting subtest: psr2-sprite-blt
[603.975470] Starting dynamic subtest: eDP-1
[605.686194] Dynamic subtest eDP-1: SUCCESS (1.712s)
[605.688503] Subtest psr2-sprite-blt: SUCCESS (1.713s)
[606.552125] [084/133] (415s left) syncobj_timeline (multi-wait-all-available-submitted)
[606.604319] Starting subtest: multi-wait-all-available-submitted
[606.606317] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[606.700226] [085/133] (414s left) gen3_render_tiledx_blits
[606.826894] [086/133] (414s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[607.077944] Starting subtest: cursor-rapid-movement-256x256
[607.080312] Starting dynamic subtest: pipe-A-eDP-1
[607.621900] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[607.651737] Starting dynamic subtest: pipe-D-eDP-1
[608.876640] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[608.879058] Subtest cursor-rapid-movement-256x256: SUCCESS (1.802s)
[609.715443] [087/133] (412s left) kms_psr (pr-primary-blt)
[609.813947] Starting subtest: pr-primary-blt
[609.818397] Subtest pr-primary-blt: SKIP (0.000s)
[609.889410] [088/133] (411s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[609.978608] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[609.982674] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[610.081355] [089/133] (411s left) gem_userptr_blits (coherency-sync)
[610.162691] Starting subtest: coherency-sync
[610.328211] Subtest coherency-sync: SKIP (0.130s)
[610.411856] [090/133] (411s left) kms_chamelium_frames (dp-frame-dump)
[610.833253] Subtest dp-frame-dump: SKIP (0.000s)
[611.633125] [091/133] (410s left) i915_selftest (live)
[614.914439] Starting subtest: live
[614.920618] Starting dynamic subtest: sanitycheck
[619.274116] Dynamic subtest sanitycheck: SUCCESS (4.360s)
[619.282708] Starting dynamic subtest: uncore
[623.610179] Dynamic subtest uncore: SUCCESS (4.335s)
[623.624912] Starting dynamic subtest: workarounds
[626.626909] Dynamic subtest workarounds: SUCCESS (3.016s)
[626.636500] Starting dynamic subtest: gt_engines
[629.659969] Dynamic subtest gt_engines: SUCCESS (3.032s)
[629.670069] Starting dynamic subtest: gt_timelines
[645.216736] Dynamic subtest gt_timelines: SUCCESS (15.556s)
[645.226586] Starting dynamic subtest: gt_contexts
[649.539814] Dynamic subtest gt_contexts: SUCCESS (4.322s)
[649.549836] Starting dynamic subtest: gt_lrc
[653.895210] Dynamic subtest gt_lrc: SUCCESS (4.354s)
[653.905457] Starting dynamic subtest: gt_mocs
[656.817191] Dynamic subtest gt_mocs: SUCCESS (2.921s)
[656.830595] Starting dynamic subtest: gt_pm
[663.543192] Dynamic subtest gt_pm: SUCCESS (6.723s)
[663.552800] Starting dynamic subtest: gt_heartbeat
[667.973792] Dynamic subtest gt_heartbeat: SUCCESS (4.429s)
[667.983183] Starting dynamic subtest: gt_tlb
[677.292557] Dynamic subtest gt_tlb: SUCCESS (9.316s)
[677.302598] Starting dynamic subtest: requests
[688.666887] Dynamic subtest requests: SUCCESS (11.371s)
[688.677223] Starting dynamic subtest: migrate
[696.377191] Dynamic subtest migrate: SUCCESS (7.707s)
[696.386176] Starting dynamic subtest: active
[699.041808] Dynamic subtest active: SUCCESS (2.662s)
[699.050940] Starting dynamic subtest: objects
[703.827571] Dynamic subtest objects: SUCCESS (4.783s)
[703.837635] Starting dynamic subtest: mman
[708.557902] Dynamic subtest mman: SUCCESS (4.728s)
[708.567748] Starting dynamic subtest: dmabuf
[711.272868] Dynamic subtest dmabuf: SUCCESS (2.713s)
[711.283560] Starting dynamic subtest: vma
[715.605828] Dynamic subtest vma: SUCCESS (4.328s)
[715.616370] Starting dynamic subtest: coherency
[720.700369] Dynamic subtest coherency: SUCCESS (5.093s)
[720.710251] Starting dynamic subtest: gtt
[730.633351] Dynamic subtest gtt: SUCCESS (9.929s)
[730.646072] Starting dynamic subtest: gem
[738.403266] Dynamic subtest gem: SUCCESS (7.767s)
[738.413615] Starting dynamic subtest: evict
[743.858808] Dynamic subtest evict: SUCCESS (5.453s)
[743.868884] Starting dynamic subtest: hugepages
[752.652557] Dynamic subtest hugepages: SUCCESS (8.790s)
[752.661136] Starting dynamic subtest: gem_contexts
[781.566868] Dynamic subtest gem_contexts: SUCCESS (28.904s)
[781.576527] Starting dynamic subtest: client
[784.351736] Dynamic subtest client: SUCCESS (2.783s)
[784.361552] Starting dynamic subtest: gem_migrate
[788.733290] Dynamic subtest gem_migrate: SUCCESS (4.377s)
[788.742484] Starting dynamic subtest: reset
[791.452134] Dynamic subtest reset: SUCCESS (2.716s)
[791.462394] Starting dynamic subtest: memory_region
[795.787915] Dynamic subtest memory_region: SUCCESS (4.334s)
[795.798019] Starting dynamic subtest: hangcheck
[808.507056] Dynamic subtest hangcheck: SUCCESS (12.715s)
[808.517203] Starting dynamic subtest: execlists
[811.145668] Dynamic subtest execlists: SUCCESS (2.637s)
[811.154890] Starting dynamic subtest: ring_submission
[815.437215] Dynamic subtest ring_submission: SUCCESS (4.288s)
[815.453154] Starting dynamic subtest: perf
[819.796138] Dynamic subtest perf: SUCCESS (4.355s)
[819.805940] Starting dynamic subtest: slpc
[831.846549] Dynamic subtest slpc: SUCCESS (12.046s)
[831.856584] Starting dynamic subtest: guc
[835.720233] Dynamic subtest guc: SUCCESS (3.872s)
[835.730569] Starting dynamic subtest: guc_multi_lrc
[840.006886] Dynamic subtest guc_multi_lrc: SUCCESS (4.284s)
[840.017041] Starting dynamic subtest: guc_hang
[845.032066] Dynamic subtest guc_hang: SUCCESS (5.022s)
[845.042466] Starting dynamic subtest: late_gt_pm
[849.339323] Dynamic subtest late_gt_pm: SUCCESS (4.304s)
[849.341928] Subtest live: SUCCESS (234.397s)
[849.371295] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[849.372053] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[849.375948] [092/133] (172s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[850.939331] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[850.943564] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[851.040528] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[851.041900] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[851.045680] [093/133] (170s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[851.144486] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[851.146330] Starting dynamic subtest: pipe-A-eDP-1
[851.204373] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[851.213080] Starting dynamic subtest: pipe-B-eDP-1
[851.266216] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s)
[851.274711] Starting dynamic subtest: pipe-C-eDP-1
[851.326704] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.060s)
[851.335133] Starting dynamic subtest: pipe-D-eDP-1
[851.385807] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.058s)
[851.388212] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.243s)
[853.649559] [094/133] (168s left) perf (polling)
[853.818226] Starting subtest: polling
[853.820478] Starting dynamic subtest: 0-rcs0
[863.855624] Dynamic subtest 0-rcs0: SUCCESS (10.042s)
[863.864903] Starting dynamic subtest: 1-vcs1
[873.895553] Dynamic subtest 1-vcs1: SUCCESS (10.042s)
[873.897930] Subtest polling: SUCCESS (20.089s)
[873.943218] [095/133] (148s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[874.044446] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[877.632198] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.593s)
[878.853203] [096/133] (143s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[878.918216] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[878.920562] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[879.032596] [097/133] (143s left) kms_prime (basic-crc-hybrid)
[879.107727] Subtest basic-crc-hybrid: SKIP (0.000s)
[879.215447] [098/133] (142s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[879.329909] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[879.334436] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[879.474173] [099/133] (142s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[879.567019] Starting subtest: x-tiled-8bpp-rotate-90
[879.591706] Subtest x-tiled-8bpp-rotate-90: SKIP (0.024s)
[879.695279] [100/133] (142s left) gen9_exec_parse (unaligned-jump)
[879.755289] Subtest unaligned-jump: SKIP (0.000s)
[879.814061] [101/133] (142s left) perf_pmu (semaphore-wait)
[879.853703] Starting subtest: semaphore-wait
[879.855301] Starting dynamic subtest: rcs0
[880.367579] Dynamic subtest rcs0: SUCCESS (0.514s)
[880.379939] Starting dynamic subtest: bcs0
[880.881319] Dynamic subtest bcs0: SUCCESS (0.511s)
[880.893816] Starting dynamic subtest: vcs0
[881.395027] Dynamic subtest vcs0: SUCCESS (0.511s)
[881.406148] Starting dynamic subtest: vcs1
[881.908599] Dynamic subtest vcs1: SUCCESS (0.511s)
[881.920678] Starting dynamic subtest: vecs0
[882.421781] Dynamic subtest vecs0: SUCCESS (0.511s)
[882.433306] Starting dynamic subtest: ccs0
[882.938565] Dynamic subtest ccs0: SUCCESS (0.514s)
[882.941516] Subtest semaphore-wait: SUCCESS (3.088s)
[883.055398] [102/133] (139s left) syncobj_wait (invalid-reset-one-illegal-handle)
[883.111155] Starting subtest: invalid-reset-one-illegal-handle
[883.113166] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[883.210167] [103/133] (139s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[883.263509] Starting subtest: yf-tiled-to-vebox-yf-tiled
[883.268014] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[883.466685] [104/133] (138s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[883.564315] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[883.566705] Starting dynamic subtest: A-eDP1
[887.149097] Dynamic subtest A-eDP1: SUCCESS (3.585s)
[887.159338] Starting dynamic subtest: B-eDP1
[890.354729] Dynamic subtest B-eDP1: SUCCESS (3.204s)
[890.365773] Starting dynamic subtest: C-eDP1
[893.460235] Dynamic subtest C-eDP1: SUCCESS (3.103s)
[893.470299] Starting dynamic subtest: D-eDP1
[896.580925] Dynamic subtest D-eDP1: SUCCESS (3.120s)
[896.583251] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.022s)
[897.385999] [105/133] (125s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[897.491779] Starting subtest: fbcpsr-rgb101010-draw-render
[904.236271] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.749s)
[904.363660] [106/133] (118s left) i915_drm_fdinfo (virtual-busy-idle-all)
[904.404601] Starting subtest: virtual-busy-idle-all
[904.409076] Subtest virtual-busy-idle-all: SKIP (0.000s)
[904.473815] [107/133] (118s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[904.529780] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[904.590276] [108/133] (117s left) kms_psr (fbc-psr-dpms)
[904.679959] Starting subtest: fbc-psr-dpms
[904.682216] Starting dynamic subtest: eDP-1
[904.686300] Dynamic subtest eDP-1: SKIP (0.000s)
[904.690425] Subtest fbc-psr-dpms: SKIP (0.001s)
[904.767765] [109/133] (117s left) gem_render_linear_blits (basic)
[904.822823] Starting subtest: basic
[904.845214] Subtest basic: SUCCESS (0.023s)
[904.930743] [110/133] (117s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[905.028556] Starting subtest: psr-rgb101010-draw-pwrite
[912.709367] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.685s)
[912.806804] [111/133] (109s left) intel_hwmon (hwmon-read)
[912.877895] Subtest hwmon-read: SKIP (0.000s)
[912.944818] [112/133] (109s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[913.043907] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[913.046379] Starting dynamic subtest: pipe-A-eDP-1
[924.021773] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.983s)
[924.031656] Starting dynamic subtest: pipe-B-eDP-1
[935.758210] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.736s)
[935.760608] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.722s)
[936.600755] [113/133] ( 86s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[936.711432] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[944.195807] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.488s)
[944.303635] [114/133] ( 78s left) gem_ctx_persistence (processes)
[944.375532] Starting subtest: processes
[945.756302] Subtest processes: SUCCESS (1.381s)
[945.836803] [115/133] ( 77s left) gem_exec_reloc (basic-gtt)
[945.900773] Subtest basic-gtt: SKIP (0.000s)
[945.971159] [116/133] ( 76s left) syncobj_eventfd (invalid-bad-flags)
[946.018802] Starting subtest: invalid-bad-flags
[946.021191] Subtest invalid-bad-flags: SUCCESS (0.000s)
[946.103361] [117/133] ( 76s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[946.206437] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[946.210819] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[946.313086] [118/133] ( 76s left) kms_atomic (crtc-invalid-params-fence)
[946.411054] Starting subtest: crtc-invalid-params-fence
[946.413342] Starting dynamic subtest: pipe-A-eDP-1
[946.811030] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[946.818890] Subtest crtc-invalid-params-fence: SUCCESS (0.402s)
[947.648398] [119/133] ( 75s left) dumb_buffer (map-valid)
[947.697498] Starting subtest: map-valid
[947.699362] Subtest map-valid: SUCCESS (0.000s)
[947.793357] [120/133] ( 75s left) gem_exec_reloc (basic-wc-read-active)
[947.848295] Subtest basic-wc-read-active: SKIP (0.000s)
[947.907743] [121/133] ( 75s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[948.000518] Starting subtest: psr-1p-pri-indfb-multidraw
[970.471180] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.474s)
[970.607226] [122/133] ( 52s left) kms_color_pipeline (plane-ctm3x4)
[970.720983] Starting subtest: plane-ctm3x4
[970.844922] Starting dynamic subtest: pipe-A-plane-0
[971.143005] Dynamic subtest pipe-A-plane-0: FAIL (0.157s)
[971.154484] Starting dynamic subtest: pipe-A-plane-1
[971.330711] Dynamic subtest pipe-A-plane-1: FAIL (0.127s)
[971.339397] Starting dynamic subtest: pipe-A-plane-2
[971.543954] Dynamic subtest pipe-A-plane-2: FAIL (0.144s)
[972.475620] Starting dynamic subtest: pipe-B-plane-0
[972.860399] Dynamic subtest pipe-B-plane-0: FAIL (0.119s)
[972.871834] Starting dynamic subtest: pipe-B-plane-1
[973.164932] Dynamic subtest pipe-B-plane-1: FAIL (0.144s)
[973.175102] Starting dynamic subtest: pipe-B-plane-2
[973.474360] Dynamic subtest pipe-B-plane-2: FAIL (0.599s)
[974.519617] Starting dynamic subtest: pipe-C-plane-0
[974.973071] Dynamic subtest pipe-C-plane-0: FAIL (0.116s)
[974.984245] Starting dynamic subtest: pipe-C-plane-1
[975.366761] Dynamic subtest pipe-C-plane-1: FAIL (0.588s)
[975.377529] Starting dynamic subtest: pipe-C-plane-2
[975.717465] Dynamic subtest pipe-C-plane-2: FAIL (0.118s)
[976.545997] Starting dynamic subtest: pipe-D-plane-0
[977.106915] Dynamic subtest pipe-D-plane-0: FAIL (0.141s)
[977.117799] Starting dynamic subtest: pipe-D-plane-1
[977.559407] Dynamic subtest pipe-D-plane-1: FAIL (0.601s)
[977.570338] Starting dynamic subtest: pipe-D-plane-2
[977.984324] Dynamic subtest pipe-D-plane-2: FAIL (0.531s)
[978.111672] Subtest plane-ctm3x4: FAIL (7.390s)
[978.925498] [123/133] ( 44s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[979.032493] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[979.037015] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[979.113558] [124/133] ( 44s left) gem_exec_big (single)
[979.165416] Starting subtest: single
[982.606650] Subtest single: FAIL (3.376s)
[982.648227] [125/133] ( 40s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[982.791290] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[982.793637] Starting dynamic subtest: pipe-A-default-mode
[985.556362] Dynamic subtest pipe-A-default-mode: SUCCESS (2.766s)
[985.558529] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.767s)
[986.411796] [126/133] ( 36s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[986.517331] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[986.521269] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[986.614412] [127/133] ( 36s left) gem_exec_fence (syncobj-channel)
[987.047648] Starting subtest: syncobj-channel
[988.073767] Subtest syncobj-channel: SUCCESS (1.022s)
[988.859623] [128/133] ( 34s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[988.974912] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[988.979473] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[989.086231] [129/133] ( 34s left) gem_pwrite (basic-random)
[989.167505] Subtest basic-random: SKIP (0.000s)
[989.223910] [130/133] ( 34s left) syncobj_wait (reset-unsignaled)
[989.292068] Starting subtest: reset-unsignaled
[989.294479] Subtest reset-unsignaled: SUCCESS (0.000s)
[989.399643] [131/133] ( 34s left) api_intel_allocator (reloc-allocator)
[989.459490] Starting subtest: reloc-allocator
[989.461478] Starting dynamic subtest: basic
[989.463759] Dynamic subtest basic: SUCCESS (0.007s)
[989.476069] Starting dynamic subtest: parallel-one
[989.478281] Dynamic subtest parallel-one: SUCCESS (0.008s)
[989.487433] Starting dynamic subtest: print
[989.489691] Dynamic subtest print: SUCCESS (0.000s)
[989.499042] Starting dynamic subtest: reuse
[989.501236] Dynamic subtest reuse: SUCCESS (0.000s)
[989.510548] Starting dynamic subtest: fork-reopen-allocator
[989.512730] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[989.514924] Subtest reloc-allocator: SUCCESS (0.033s)
[989.626313] [132/133] ( 33s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[989.721032] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[990.848377] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.125s)
[990.981817] [133/133] ( 32s left) gen9_exec_parse (allowed-single)
[991.035957] Subtest allowed-single: SKIP (0.000s)
[991.108552] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: kms_chamelium_audio
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: kms_sequence
results: parsing output: 5/ for test: gem_mmap_offset
results: parsing output: 6/ for test: gem_mmap
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_ctx_bad_destroy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: gem_wait
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_content_protection
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: prime_mmap
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: kms_hdr
results: parsing output: 29/ for test: kms_cursor_edge_walk
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: gem_linear_blits
results: parsing output: 32/ for test: kms_setmode
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: dumb_buffer
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_getfb
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: kms_lease
results: parsing output: 40/ for test: kms_addfb_basic
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: gem_lmem_swapping
results: parsing output: 46/ for test: gem_create
results: parsing output: 47/ for test: api_intel_bb
results: parsing output: 48/ for test: kms_pipe_crc_basic
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: gem_exec_balancer
results: parsing output: 51/ for test: kms_dp_link_training
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_exec_flush
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: drm_read
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: vgem_basic
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: kms_pm_dc
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_softpin
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: gem_ctx_param
results: parsing output: 72/ for test: gem_eio
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_pxp
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: gem_exec_alignment
results: parsing output: 80/ for test: kms_cursor_crc
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gen3_render_tiledx_blits
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: kms_chamelium_frames
results: parsing output: 90/ for test: i915_selftest
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_prime
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gen9_exec_parse
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: i915_drm_fdinfo
results: parsing output: 106/ for test: kms_pipe_b_c_ivb
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_render_linear_blits
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: intel_hwmon
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: syncobj_eventfd
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_atomic
results: parsing output: 118/ for test: dumb_buffer
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_color_pipeline
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: gem_exec_big
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_pwrite
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: api_intel_allocator
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: gen9_exec_parse
Done.