[58.864159] Initializing watchdogs
[58.864307]   /dev/watchdog0
[58.880117] [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]
[58.884667] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.887114] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.890858] [001/133] (960s left) kms_flip (wf_vblank-ts-check-interruptible)
[59.011719] Starting subtest: wf_vblank-ts-check-interruptible
[59.014235] Starting dynamic subtest: A-eDP1
[67.985257] Dynamic subtest A-eDP1: SUCCESS (8.973s)
[67.996221] Starting dynamic subtest: B-eDP1
[76.893117] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[76.901771] Starting dynamic subtest: C-eDP1
[85.817702] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[85.827217] Starting dynamic subtest: D-eDP1
[94.754885] Dynamic subtest D-eDP1: SUCCESS (8.936s)
[94.760589] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.770s)
[95.991741] [002/133] (923s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[96.098134] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[96.102573] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[96.204716] [003/133] (923s left) kms_plane (pixel-format-linear-modifier)
[96.298527] Starting subtest: pixel-format-linear-modifier
[96.335081] Starting dynamic subtest: pipe-A-plane-0
[99.879064] Dynamic subtest pipe-A-plane-0: SUCCESS (3.545s)
[99.887483] Starting dynamic subtest: pipe-A-plane-3
[101.523218] Dynamic subtest pipe-A-plane-3: SUCCESS (1.644s)
[101.531903] Starting dynamic subtest: pipe-A-plane-5
[101.734555] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[102.872217] Starting dynamic subtest: pipe-B-plane-0
[106.473940] Dynamic subtest pipe-B-plane-0: SUCCESS (3.611s)
[106.483194] Starting dynamic subtest: pipe-B-plane-3
[108.163135] Dynamic subtest pipe-B-plane-3: SUCCESS (1.689s)
[108.170520] Starting dynamic subtest: pipe-B-plane-5
[108.373953] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[108.687524] Subtest pixel-format-linear-modifier: SUCCESS (12.390s)
[109.538905] [004/133] (909s left) sysfs_heartbeat_interval (nopreempt)
[109.606474] Starting subtest: nopreempt
[109.608956] Starting dynamic subtest: vecs0
[118.929410] Dynamic subtest vecs0: SUCCESS (9.323s)
[118.940369] Starting dynamic subtest: ccs0
[122.955332] Dynamic subtest ccs0: SUCCESS (4.024s)
[122.966346] Starting dynamic subtest: vcs0
[132.884187] Dynamic subtest vcs0: SUCCESS (9.926s)
[132.895019] Starting dynamic subtest: bcs0
[136.833804] Dynamic subtest bcs0: SUCCESS (3.950s)
[136.844671] Starting dynamic subtest: rcs0
[140.879864] Dynamic subtest rcs0: SUCCESS (4.047s)
[140.890494] Starting dynamic subtest: vcs1
[150.936702] Dynamic subtest vcs1: SUCCESS (10.052s)
[150.939029] Subtest nopreempt: SUCCESS (41.328s)
[151.020756] [005/133] (868s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[151.142581] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[151.833705] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.692s)
[151.992194] [006/133] (867s left) kms_addfb_basic (bad-pitch-256)
[152.054180] Starting subtest: bad-pitch-256
[152.056650] Subtest bad-pitch-256: SUCCESS (0.000s)
[152.177905] [007/133] (867s left) kms_cursor_legacy (torture-move)
[152.303766] Starting subtest: torture-move
[152.306204] Starting dynamic subtest: pipe-A
[158.307645] Dynamic subtest pipe-A: SUCCESS (6.001s)
[158.322372] Starting dynamic subtest: pipe-B
[165.090502] Dynamic subtest pipe-B: SUCCESS (6.782s)
[165.100307] Starting dynamic subtest: pipe-C
[171.831628] Dynamic subtest pipe-C: SUCCESS (6.740s)
[171.840969] Starting dynamic subtest: pipe-D
[177.566450] Dynamic subtest pipe-D: SUCCESS (5.734s)
[177.580749] Starting dynamic subtest: all-pipes
[184.091791] Dynamic subtest all-pipes: SUCCESS (6.523s)
[184.094299] Subtest torture-move: SUCCESS (31.785s)
[184.251701] [008/133] (835s left) gem_ppgtt (shrink-vs-evict-any)
[184.306140] Starting subtest: shrink-vs-evict-any
[189.875306] Subtest shrink-vs-evict-any: SUCCESS (5.569s)
[189.972991] [009/133] (829s left) syncobj_timeline (wait-all-for-submit-snapshot)
[190.036529] Starting subtest: wait-all-for-submit-snapshot
[190.117552] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[190.191498] [010/133] (829s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[190.284082] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[190.288147] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[190.379549] [011/133] (829s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[190.774265] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[191.544847] [012/133] (828s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[191.639905] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[191.644088] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[191.738925] [013/133] (828s left) gem_mmap_gtt (basic-write-read-distinct)
[191.801229] Subtest basic-write-read-distinct: SKIP (0.000s)
[191.858873] [014/133] (828s left) perf_pmu (busy-no-semaphores)
[191.907909] Starting subtest: busy-no-semaphores
[191.909770] Starting dynamic subtest: rcs0
[192.474956] Dynamic subtest rcs0: SUCCESS (0.567s)
[192.485850] Starting dynamic subtest: bcs0
[193.023259] Dynamic subtest bcs0: SUCCESS (0.547s)
[193.035767] Starting dynamic subtest: vcs0
[193.572737] Dynamic subtest vcs0: SUCCESS (0.547s)
[193.584613] Starting dynamic subtest: vcs1
[195.417281] Dynamic subtest vcs1: SUCCESS (1.842s)
[195.428962] Starting dynamic subtest: vecs0
[197.465780] Dynamic subtest vecs0: SUCCESS (2.046s)
[197.477602] Starting dynamic subtest: ccs0
[199.450513] Dynamic subtest ccs0: SUCCESS (1.983s)
[199.453599] Subtest busy-no-semaphores: SUCCESS (7.543s)
[199.566769] [015/133] (820s left) core_getstats (basic)
[199.623817] Starting subtest: basic
[199.626064] Subtest basic: SUCCESS (0.000s)
[199.732383] [016/133] (820s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[199.810336] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[199.814522] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[200.008465] [017/133] (820s left) gem_exec_alignment (pi)
[200.083683] Starting subtest: pi
[252.348243] Subtest pi: SUCCESS (52.261s)
[253.551424] [018/133] (766s left) gem_lmem_swapping (smem-oom)
[253.637748] Subtest smem-oom: SKIP (0.000s)
[253.681471] [019/133] (766s left) kms_prop_blob (blob-prop-lifetime)
[253.736939] Starting subtest: blob-prop-lifetime
[253.739349] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[253.847331] [020/133] (766s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[253.964377] Starting subtest: extended-modeset-hang-oldfb-with-reset
[253.966692] Starting dynamic subtest: pipe-A
[265.636244] Dynamic subtest pipe-A: SUCCESS (11.669s)
[265.647921] Starting dynamic subtest: pipe-D
[277.918080] Dynamic subtest pipe-D: SUCCESS (12.279s)
[277.920166] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.952s)
[278.707884] [021/133] (741s left) gem_exec_await (wide-all)
[279.007368] Starting subtest: wide-all
[302.604261] Subtest wide-all: SUCCESS (23.593s)
[302.810340] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true
[302.815303] [022/133] (717s left) kms_hdr (static-toggle-suspend)
[302.954272] Starting subtest: static-toggle-suspend
[302.960795] Subtest static-toggle-suspend: SKIP (0.000s)
[303.032758] [023/133] (717s left) gem_ctx_param (vm)
[303.078487] Starting subtest: vm
[303.127354] Subtest vm: SUCCESS (0.048s)
[303.244079] [024/133] (717s left) gem_mmap_gtt (big-copy-odd)
[303.306046] Subtest big-copy-odd: SKIP (0.000s)
[303.370651] [025/133] (716s left) kms_cursor_crc (cursor-random-128x128)
[303.608902] Starting subtest: cursor-random-128x128
[303.611262] Starting dynamic subtest: pipe-A-eDP-1
[306.953210] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.341s)
[306.982108] Starting dynamic subtest: pipe-D-eDP-1
[310.930632] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.957s)
[310.932783] Subtest cursor-random-128x128: SUCCESS (7.323s)
[311.785323] [026/133] (708s left) vgem_basic (unload)
[311.827055] Starting subtest: unload
[340.879485] Subtest unload: SUCCESS (29.051s)
[340.992358] [027/133] (679s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[341.101365] Starting subtest: x-tiled-8bpp-rotate-90
[341.127253] Subtest x-tiled-8bpp-rotate-90: SKIP (0.023s)
[341.227508] [028/133] (679s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[341.323985] Starting subtest: multiplane-rotation-cropping-top
[358.761924] Subtest multiplane-rotation-cropping-top: SUCCESS (17.438s)
[358.903197] [029/133] (661s left) sw_sync (alloc_fence_invalid_timeline)
[358.947372] Starting subtest: alloc_fence_invalid_timeline
[358.949258] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[358.998361] [030/133] (661s left) kms_setmode (invalid-clone-exclusive-crtc)
[359.057077] Starting subtest: invalid-clone-exclusive-crtc
[359.062627] Subtest invalid-clone-exclusive-crtc: SKIP (0.001s)
[359.165654] [031/133] (661s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[359.222411] Starting subtest: etime-multi-wait-all-available-unsubmitted
[359.331405] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s)
[359.415852] [032/133] (661s left) gem_mmap_gtt (big-bo-tiledx)
[359.475278] Subtest big-bo-tiledX: SKIP (0.000s)
[359.537277] [033/133] (661s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[359.626129] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[359.628387] Starting dynamic subtest: pipe-A-eDP-1
[359.650327] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[359.660997] Starting dynamic subtest: pipe-B-eDP-1
[359.681250] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[359.690104] Starting dynamic subtest: pipe-C-eDP-1
[359.710295] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[359.721936] Starting dynamic subtest: pipe-D-eDP-1
[359.744660] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[359.749208] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[361.878557] [034/133] (658s left) gem_userptr_blits (readonly-unsync)
[361.946250] Subtest readonly-unsync: SKIP (0.000s)
[362.059105] [035/133] (658s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[362.160340] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[362.164739] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[362.257445] [036/133] (658s left) syncobj_wait (multi-wait-for-submit-submitted)
[362.313331] Starting subtest: multi-wait-for-submit-submitted
[362.418603] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s)
[362.497810] [037/133] (658s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[362.568689] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[362.675137] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[362.751927] [038/133] (658s left) kms_draw_crc (draw-method-mmap-wc)
[362.849232] Starting subtest: draw-method-mmap-wc
[362.851080] Starting dynamic subtest: xrgb8888-untiled
[363.068414] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s)
[363.078082] Starting dynamic subtest: rgb565-untiled
[363.279814] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[363.289380] Starting dynamic subtest: xrgb2101010-untiled
[363.480962] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[363.491089] Starting dynamic subtest: xbgr16161616f-untiled
[363.701784] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.220s)
[363.711079] Starting dynamic subtest: xrgb8888-xtiled
[363.834651] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[363.843783] Starting dynamic subtest: rgb565-xtiled
[363.971281] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[363.981013] Starting dynamic subtest: xrgb2101010-xtiled
[364.123928] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.153s)
[364.136036] Starting dynamic subtest: xbgr16161616f-xtiled
[364.257046] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[364.266211] Starting dynamic subtest: xrgb8888-4tiled
[364.412800] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[364.425233] Starting dynamic subtest: rgb565-4tiled
[364.557068] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[364.566519] Starting dynamic subtest: xrgb2101010-4tiled
[364.712905] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[364.722884] Starting dynamic subtest: xbgr16161616f-4tiled
[364.890608] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[364.892580] Subtest draw-method-mmap-wc: SUCCESS (2.044s)
[364.986329] [039/133] (655s left) gem_render_linear_blits (basic)
[365.052695] Starting subtest: basic
[365.074552] Subtest basic: SUCCESS (0.022s)
[365.160641] [040/133] (655s left) kms_pm_rpm (fences-dpms)
[367.042715] Starting subtest: fences-dpms
[367.047813] Subtest fences-dpms: SKIP (0.000s)
[367.509868] [041/133] (653s left) kms_cursor_crc (cursor-dpms)
[367.629380] Starting subtest: cursor-dpms
[367.631690] Starting dynamic subtest: pipe-A-eDP-1
[370.661996] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.031s)
[370.671693] Starting dynamic subtest: pipe-D-eDP-1
[374.258689] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.595s)
[374.261189] Subtest cursor-dpms: SUCCESS (6.629s)
[375.106652] [042/133] (645s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[375.206862] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[375.209043] Starting dynamic subtest: pipe-A
[375.228861] Dynamic subtest pipe-A: SKIP (0.018s)
[375.238607] Starting dynamic subtest: pipe-B
[375.260845] Dynamic subtest pipe-B: SKIP (0.031s)
[375.270448] Starting dynamic subtest: pipe-C
[375.295197] Dynamic subtest pipe-C: SKIP (0.034s)
[375.304657] Starting dynamic subtest: pipe-D
[375.326504] Dynamic subtest pipe-D: SKIP (0.031s)
[375.330642] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.117s)
[375.420764] [043/133] (645s left) kms_color (ctm-blue-to-red)
[375.511284] Starting subtest: ctm-blue-to-red
[375.513121] Starting dynamic subtest: pipe-A-eDP-1
[376.199908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[376.210359] Starting dynamic subtest: pipe-B-eDP-1
[377.577719] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.378s)
[377.587665] Starting dynamic subtest: pipe-C-eDP-1
[378.940564] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.362s)
[378.950608] Starting dynamic subtest: pipe-D-eDP-1
[380.293748] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.354s)
[380.296091] Subtest ctm-blue-to-red: SUCCESS (4.785s)
[381.122920] [044/133] (640s left) kms_plane_alpha_blend (constant-alpha-min)
[381.212036] Starting subtest: constant-alpha-min
[381.496544] Starting dynamic subtest: pipe-A-eDP-1
[382.213913] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[382.223846] Starting dynamic subtest: pipe-D-eDP-1
[383.710653] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.495s)
[383.713141] Subtest constant-alpha-min: SUCCESS (2.500s)
[384.578684] [045/133] (636s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[384.680794] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[384.685375] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[384.786158] [046/133] (636s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[384.879488] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[384.881889] Starting dynamic subtest: pipe-A-eDP-1
[384.903257] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[384.913475] Starting dynamic subtest: pipe-B-eDP-1
[384.934169] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[384.943591] Starting dynamic subtest: pipe-C-eDP-1
[384.964548] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[384.973666] Starting dynamic subtest: pipe-D-eDP-1
[384.995718] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[384.999762] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[387.158836] [047/133] (634s left) kms_lease (lease-uevent)
[387.250624] Starting subtest: lease-uevent
[388.267149] Subtest lease-uevent: SUCCESS (1.016s)
[388.382455] [048/133] (632s left) gen7_exec_parse (oacontrol-tracking)
[388.450783] Subtest oacontrol-tracking: SKIP (0.000s)
[388.521423] [049/133] (632s left) gem_userptr_blits (unsync-unmap-cycles)
[388.583858] Subtest unsync-unmap-cycles: SKIP (0.000s)
[388.702567] [050/133] (632s left) kms_flip (basic-flip-vs-modeset)
[388.794111] Starting subtest: basic-flip-vs-modeset
[388.796363] Starting dynamic subtest: A-eDP1
[391.341734] Dynamic subtest A-eDP1: SUCCESS (2.546s)
[391.351580] Starting dynamic subtest: B-eDP1
[393.494471] Dynamic subtest B-eDP1: SUCCESS (2.152s)
[393.505086] Starting dynamic subtest: C-eDP1
[395.648151] Dynamic subtest C-eDP1: SUCCESS (2.155s)
[395.659056] Starting dynamic subtest: D-eDP1
[397.801635] Dynamic subtest D-eDP1: SUCCESS (2.150s)
[397.804026] Subtest basic-flip-vs-modeset: SUCCESS (9.010s)
[398.609174] [051/133] (622s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[398.667981] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[398.670304] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[398.759483] [052/133] (622s left) syncobj_timeline (reset-during-wait-for-submit)
[398.813989] Starting subtest: reset-during-wait-for-submit
[398.915773] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[399.007383] [053/133] (622s left) perf (buffer-fill)
[399.151438] Starting subtest: buffer-fill
[399.153747] Starting dynamic subtest: 0-rcs0
[401.408835] Dynamic subtest 0-rcs0: SUCCESS (2.256s)
[401.419652] Starting dynamic subtest: 1-vecs0
[405.851788] Dynamic subtest 1-vecs0: SUCCESS (4.441s)
[405.854322] Subtest buffer-fill: SUCCESS (6.700s)
[405.902899] [054/133] (615s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[406.005494] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[410.084113] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.080s)
[411.305349] [055/133] (610s left) prime_vgem (wait)
[411.383399] Starting subtest: wait
[411.385604] Starting dynamic subtest: rcs0
[411.435214] Dynamic subtest rcs0: SUCCESS (0.054s)
[411.445423] Starting dynamic subtest: bcs0
[411.484846] Dynamic subtest bcs0: SUCCESS (0.049s)
[411.496122] Starting dynamic subtest: vcs0
[411.529174] Dynamic subtest vcs0: SUCCESS (0.043s)
[411.538820] Starting dynamic subtest: vcs1
[411.573132] Dynamic subtest vcs1: SUCCESS (0.043s)
[411.582968] Starting dynamic subtest: vecs0
[411.618848] Dynamic subtest vecs0: SUCCESS (0.045s)
[411.628586] Starting dynamic subtest: ccs0
[411.667430] Dynamic subtest ccs0: SUCCESS (0.048s)
[411.669774] Subtest wait: SUCCESS (0.288s)
[411.797925] [056/133] (609s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[411.900352] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[412.903124] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.005s)
[413.059467] [057/133] (608s left) gem_exec_fence (syncobj-timeline-unused-fence)
[413.597971] Starting subtest: syncobj-timeline-unused-fence
[413.604239] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[415.018760] [058/133] (606s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[415.110615] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[415.112792] Starting dynamic subtest: pipe-A-default-mode
[417.825187] Dynamic subtest pipe-A-default-mode: SUCCESS (2.712s)
[417.827107] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.714s)
[418.687425] [059/133] (603s left) kms_psr (pr-basic)
[418.781521] Starting subtest: pr-basic
[418.785658] Subtest pr-basic: SKIP (0.000s)
[418.859635] [060/133] (602s left) dmabuf_sync_file (export-wait-after-attach)
[418.907167] Starting subtest: export-wait-after-attach
[418.909424] Subtest export-wait-after-attach: SUCCESS (0.003s)
[418.973734] [061/133] (602s left) gem_exec_balancer (busy)
[419.029486] Starting subtest: busy
[420.883334] Subtest busy: SUCCESS (1.852s)
[421.231255] [062/133] (600s left) gem_userptr_blits (dmabuf-unsync)
[421.296210] Subtest dmabuf-unsync: SKIP (0.000s)
[421.426502] [063/133] (600s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[421.562620] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[422.981340] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.418s)
[423.851289] [064/133] (598s left) gem_render_copy (yf-tiled-ccs-to-linear)
[423.917393] Starting subtest: yf-tiled-ccs-to-linear
[423.921848] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[424.120332] [065/133] (597s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[424.224621] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[424.226738] Starting dynamic subtest: pipe-A-eDP-1
[440.742063] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.519s)
[440.752368] Starting dynamic subtest: pipe-B-eDP-1
[457.922060] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.178s)
[457.924373] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.699s)
[458.732678] [066/133] (563s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[458.830397] Starting subtest: pr-overlay-plane-move-continuous-sf
[458.834262] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[458.901866] [067/133] (563s left) i915_selftest (mock)
[462.192456] Starting subtest: mock
[462.195309] Starting dynamic subtest: sanitycheck
[462.907150] Dynamic subtest sanitycheck: SUCCESS (0.714s)
[462.917258] Starting dynamic subtest: shmem
[463.575173] Dynamic subtest shmem: SUCCESS (0.666s)
[463.585242] Starting dynamic subtest: fence
[471.045358] Dynamic subtest fence: SUCCESS (7.467s)
[471.055853] Starting dynamic subtest: scatterlist
[472.730490] Dynamic subtest scatterlist: SUCCESS (1.684s)
[472.740869] Starting dynamic subtest: syncmap
[476.036703] Dynamic subtest syncmap: SUCCESS (3.303s)
[476.048925] Starting dynamic subtest: uncore
[476.700187] Dynamic subtest uncore: SUCCESS (0.662s)
[476.710491] Starting dynamic subtest: ring
[477.380292] Dynamic subtest ring: SUCCESS (0.678s)
[477.393282] Starting dynamic subtest: engine
[478.063305] Dynamic subtest engine: SUCCESS (0.681s)
[478.073569] Starting dynamic subtest: timelines
[481.878398] Dynamic subtest timelines: SUCCESS (3.812s)
[481.888604] Starting dynamic subtest: requests
[485.303531] Dynamic subtest requests: SUCCESS (3.424s)
[485.315112] Starting dynamic subtest: objects
[486.052263] Dynamic subtest objects: SUCCESS (0.748s)
[486.061949] Starting dynamic subtest: phys
[486.864613] Dynamic subtest phys: SUCCESS (0.811s)
[486.874058] Starting dynamic subtest: dmabuf
[487.632076] Dynamic subtest dmabuf: SUCCESS (0.766s)
[487.642185] Starting dynamic subtest: vma
[493.408312] Dynamic subtest vma: SUCCESS (5.774s)
[493.417084] Starting dynamic subtest: evict
[494.830196] Dynamic subtest evict: SUCCESS (1.420s)
[494.840110] Starting dynamic subtest: gtt
[498.165554] Dynamic subtest gtt: SUCCESS (3.334s)
[498.178203] Starting dynamic subtest: hugepages
[499.059613] Dynamic subtest hugepages: SUCCESS (0.893s)
[499.070636] Starting dynamic subtest: memory_region
[501.691103] Dynamic subtest memory_region: SUCCESS (2.629s)
[501.693815] Subtest mock: SUCCESS (39.498s)
[501.723382] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[501.724091] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[501.727322] [068/133] (520s left) kms_pm_dc (dc5-dpms)
[504.318188] Starting subtest: dc5-dpms
[506.401690] Subtest dc5-dpms: SUCCESS (2.084s)
[506.510409] [FACT kms_pm_dc (dc5-dpms)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[506.511683] [FACT kms_pm_dc (dc5-dpms)] new: kernel.kmod_is_loaded.i915: true
[506.515969] [069/133] (515s left) kms_tiled_display (basic-test-pattern)
[506.636286] Subtest basic-test-pattern: SKIP (0.000s)
[506.681159] [070/133] (515s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[506.785995] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[514.217288] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.436s)
[514.363973] [071/133] (507s left) gem_vm_create (execbuf)
[514.432462] Starting subtest: execbuf
[514.440100] Subtest execbuf: SUCCESS (0.007s)
[514.569440] [072/133] (507s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[514.669758] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[521.711345] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.046s)
[521.812195] [073/133] (500s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[521.913289] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[528.178899] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.269s)
[529.395641] [074/133] (493s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[529.494811] Starting subtest: pipe-fbc-rte
[529.501837] Starting dynamic subtest: pipe-B-eDP-1
[534.971602] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.480s)
[534.979339] Subtest pipe-fbc-rte: SUCCESS (5.483s)
[537.256912] [075/133] (485s left) gem_userptr_blits (sync-unmap)
[537.322073] Starting subtest: sync-unmap
[537.335483] Subtest sync-unmap: SUCCESS (0.014s)
[537.452775] [076/133] (485s left) gem_exec_balancer (sliced)
[537.522787] Starting subtest: sliced
[537.527325] Subtest sliced: SKIP (0.000s)
[537.809469] [077/133] (484s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[537.894444] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[537.903507] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[537.983928] [078/133] (484s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[538.031069] Starting subtest: invalid-signal-one-illegal-handle
[538.033295] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[538.129967] [079/133] (484s left) kms_vblank (wait-busy)
[538.220724] Starting subtest: wait-busy
[538.222966] Starting dynamic subtest: pipe-A-eDP-1
[540.101998] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[540.123614] Starting dynamic subtest: pipe-D-eDP-1
[542.709966] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.606s)
[542.712447] Subtest wait-busy: SUCCESS (4.489s)
[543.515133] [080/133] (479s left) kms_psr (psr2-dpms)
[543.604740] Starting subtest: psr2-dpms
[543.607064] Starting dynamic subtest: eDP-1
[546.442833] Dynamic subtest eDP-1: SUCCESS (2.837s)
[546.445114] Subtest psr2-dpms: SUCCESS (2.838s)
[547.312499] [081/133] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[547.407378] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[547.411704] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[547.527604] [082/133] (475s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[547.640195] Starting subtest: cursorB-vs-flipB-toggle
[547.644530] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[547.789120] [083/133] (475s left) kms_addfb_basic (bad-pitch-65536)
[547.839830] Starting subtest: bad-pitch-65536
[547.841988] Subtest bad-pitch-65536: SUCCESS (0.000s)
[547.986321] [084/133] (474s left) fbdev (eof)
[548.036381] Starting subtest: eof
[548.038558] Subtest eof: SUCCESS (0.000s)
[548.134685] [085/133] (474s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[548.248718] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[548.250546] Starting dynamic subtest: pipe-A-eDP-1
[548.271325] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[548.283547] Starting dynamic subtest: pipe-B-eDP-1
[548.302758] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[548.311149] Starting dynamic subtest: pipe-C-eDP-1
[548.329986] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[548.339548] Starting dynamic subtest: pipe-D-eDP-1
[548.358918] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[548.362483] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[550.489263] [086/133] (472s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[550.558799] Starting subtest: legacy-engines-hostile-preempt
[550.561078] Starting dynamic subtest: render
[550.622463] Dynamic subtest render: SUCCESS (0.063s)
[550.636343] Starting dynamic subtest: bsd1
[551.889259] Dynamic subtest bsd1: SUCCESS (1.263s)
[551.900584] Starting dynamic subtest: bsd2
[553.876577] Dynamic subtest bsd2: SUCCESS (1.983s)
[553.888327] Starting dynamic subtest: blt
[553.907458] Dynamic subtest blt: SUCCESS (0.030s)
[553.916376] Starting dynamic subtest: vebox
[555.926067] Dynamic subtest vebox: SUCCESS (2.016s)
[555.928883] Subtest legacy-engines-hostile-preempt: SUCCESS (5.367s)
[556.019421] [087/133] (466s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[556.125174] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[556.129170] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[556.214637] [088/133] (466s left) gem_exec_schedule (in-order)
[556.290490] Starting subtest: in-order
[556.292831] Starting dynamic subtest: rcs0
[556.399544] Dynamic subtest rcs0: SUCCESS (0.117s)
[556.411568] Starting dynamic subtest: vcs0
[556.481319] Dynamic subtest vcs0: SUCCESS (0.081s)
[556.493919] Starting dynamic subtest: vcs1
[556.574865] Dynamic subtest vcs1: SUCCESS (0.093s)
[556.587068] Starting dynamic subtest: vecs0
[556.659831] Dynamic subtest vecs0: SUCCESS (0.083s)
[556.668836] Starting dynamic subtest: ccs0
[556.750585] Dynamic subtest ccs0: SUCCESS (0.090s)
[556.753073] Subtest in-order: SUCCESS (0.469s)
[558.009520] [089/133] (465s left) kms_psr (fbc-psr-primary-mmap-cpu)
[558.107903] Starting subtest: fbc-psr-primary-mmap-cpu
[558.110254] Starting dynamic subtest: eDP-1
[558.114372] Dynamic subtest eDP-1: SKIP (0.000s)
[558.118534] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[558.187199] [090/133] (464s left) kms_fbcon_fbt (fbc-suspend)
[558.243491] Starting subtest: fbc-suspend
[608.058182] Subtest fbc-suspend: SUCCESS (19.174s)
[609.418393] [091/133] (413s left) kms_plane_scaling (invalid-num-scalers)
[609.525559] Starting subtest: invalid-num-scalers
[609.528399] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[609.544379] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[609.554910] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[609.573315] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[609.583859] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[609.608312] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[609.618574] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[609.641275] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[609.643736] Subtest invalid-num-scalers: SUCCESS (0.118s)
[609.741967] [092/133] (413s left) gem_workarounds (reset-fd)
[609.830742] Starting subtest: reset-fd
[610.018273] Subtest reset-fd: SUCCESS (0.192s)
[610.142580] [093/133] (413s left) i915_pm_rc6_residency (rc6-idle)
[610.194594] Starting subtest: rc6-idle
[610.225875] Starting dynamic subtest: gt0-rcs0
[634.545234] Dynamic subtest gt0-rcs0: SUCCESS (24.361s)
[634.555602] Starting dynamic subtest: gt0-bcs0
[658.877765] Dynamic subtest gt0-bcs0: SUCCESS (24.330s)
[658.890502] Starting dynamic subtest: gt0-ccs0
[683.152832] Dynamic subtest gt0-ccs0: SUCCESS (24.280s)
[683.165093] Starting dynamic subtest: gt1-vcs0
[689.327899] Dynamic subtest gt1-vcs0: SUCCESS (6.174s)
[689.341131] Starting dynamic subtest: gt1-vecs0
[695.500307] Dynamic subtest gt1-vecs0: SUCCESS (6.172s)
[695.503277] Subtest rc6-idle: SUCCESS (85.362s)
[695.582165] [094/133] (327s left) i915_module_load (reload-no-display)
[695.621051] Starting subtest: reload-no-display
[700.739891] Subtest reload-no-display: SUCCESS (5.125s)
[700.770320] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[700.771088] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[700.774389] [095/133] (322s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[703.241903] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[707.790867] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.552s)
[709.020088] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[709.021318] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)] new: kernel.kmod_is_loaded.i915: true
[709.025701] [096/133] (314s left) kms_plane_cursor (viewport)
[709.126185] Starting subtest: viewport
[709.131056] Starting dynamic subtest: pipe-A-eDP-1-size-64
[711.617199] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.491s)
[711.686794] Starting dynamic subtest: pipe-A-eDP-1-size-128
[714.188162] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.518s)
[714.248246] Starting dynamic subtest: pipe-A-eDP-1-size-256
[716.766240] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.526s)
[717.132942] Starting dynamic subtest: pipe-B-eDP-1-size-64
[720.291621] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.168s)
[720.354226] Starting dynamic subtest: pipe-B-eDP-1-size-128
[722.836246] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.494s)
[722.895640] Starting dynamic subtest: pipe-B-eDP-1-size-256
[725.492237] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.605s)
[725.846473] Starting dynamic subtest: pipe-C-eDP-1-size-64
[728.602614] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.767s)
[728.643075] Starting dynamic subtest: pipe-C-eDP-1-size-128
[730.792392] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.159s)
[730.830000] Starting dynamic subtest: pipe-C-eDP-1-size-256
[732.926001] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.103s)
[733.259277] Starting dynamic subtest: pipe-D-eDP-1-size-64
[736.063228] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.816s)
[736.101569] Starting dynamic subtest: pipe-D-eDP-1-size-128
[738.229941] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.136s)
[738.267991] Starting dynamic subtest: pipe-D-eDP-1-size-256
[740.408296] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s)
[740.730324] Subtest viewport: SUCCESS (31.597s)
[741.594902] [097/133] (281s left) gem_exec_whisper (basic-fds-forked)
[741.673020] Starting subtest: basic-fds-forked
[767.938924] Subtest basic-fds-forked: SUCCESS (26.265s)
[768.135715] [098/133] (255s left) gem_mmap_gtt (zero-extend)
[768.193434] Subtest zero-extend: SKIP (0.000s)
[768.251922] [099/133] (255s left) kms_chamelium_frames (dp-crc-single)
[768.647016] Subtest dp-crc-single: SKIP (0.000s)
[769.493081] [100/133] (254s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[769.591761] Starting subtest: psr-rgb101010-draw-mmap-wc
[776.677993] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.091s)
[776.790615] [101/133] (246s left) gem_exec_reloc (basic-gtt-read-noreloc)
[776.852386] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[776.920296] [102/133] (246s left) kms_properties (get_properties-sanity-atomic)
[777.013025] Starting subtest: get_properties-sanity-atomic
[777.015450] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[777.090790] [103/133] (246s left) gem_softpin (evict-single-offset)
[777.154197] Starting subtest: evict-single-offset
[805.676984] Subtest evict-single-offset: SUCCESS (28.528s)
[805.777208] [104/133] (217s left) kms_addfb_basic (invalid-set-prop-any)
[805.875876] Starting subtest: invalid-set-prop-any
[805.878706] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[806.009681] [105/133] (217s left) gem_create (create-massive)
[806.072621] Starting subtest: create-massive
[806.075453] Subtest create-massive: SUCCESS (0.000s)
[806.259089] [106/133] (217s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[806.367855] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[806.372624] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[806.460149] [107/133] (217s left) kms_flip (2x-flip-vs-suspend-interruptible)
[806.559335] Starting subtest: 2x-flip-vs-suspend-interruptible
[806.571274] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s)
[806.649904] [108/133] (217s left) gem_exec_fence (syncobj-channel)
[807.180199] Starting subtest: syncobj-channel
[808.206295] Subtest syncobj-channel: SUCCESS (1.023s)
[808.736996] [109/133] (215s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[808.835233] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[812.827546] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.996s)
[814.033946] [110/133] (209s left) gem_eio (in-flight-contexts-immediate)
[814.269319] Starting subtest: in-flight-contexts-immediate
[827.645748] Subtest in-flight-contexts-immediate: SUCCESS (13.379s)
[827.797928] [111/133] (196s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[827.861811] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[827.923085] [112/133] (196s left) kms_async_flips (async-flip-hang)
[828.018501] Starting subtest: async-flip-hang
[828.392282] Starting dynamic subtest: pipe-A-eDP-1
[831.580602] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.185s)
[831.979290] Starting dynamic subtest: pipe-B-eDP-1
[835.206500] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.235s)
[835.596569] Starting dynamic subtest: pipe-C-eDP-1
[838.839623] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.255s)
[839.221490] Starting dynamic subtest: pipe-D-eDP-1
[842.472207] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.257s)
[842.475284] Subtest async-flip-hang: SUCCESS (14.449s)
[843.697147] [113/133] (180s left) kms_psr (fbc-pr-sprite-render)
[843.790265] Starting subtest: fbc-pr-sprite-render
[843.794988] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[843.865329] [114/133] (180s left) gem_flink_basic (bad-open)
[843.919281] Starting subtest: bad-open
[843.922008] Subtest bad-open: SUCCESS (0.000s)
[844.006244] [115/133] (180s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[844.102939] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[844.108157] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[844.189744] [116/133] (180s left) kms_getfb (getfb2-handle-closed)
[844.278451] Starting subtest: getfb2-handle-closed
[844.280996] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[844.376958] [117/133] (179s left) gem_exec_params (no-vebox)
[844.442496] Starting subtest: no-vebox
[844.445078] Subtest no-vebox: SUCCESS (0.003s)
[845.753863] [118/133] (178s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[845.856304] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[845.860944] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[845.966017] [119/133] (178s left) kms_atomic (plane-immutable-zpos)
[846.064267] Starting subtest: plane-immutable-zpos
[846.066734] Starting dynamic subtest: pipe-A-eDP-1
[846.728874] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.663s)
[846.731502] Subtest plane-immutable-zpos: SUCCESS (0.664s)
[847.642492] [120/133] (176s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[847.739400] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[847.744481] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[847.833258] [121/133] (176s left) api_intel_allocator (alloc-simple)
[847.887423] Starting subtest: alloc-simple
[847.890296] Subtest alloc-simple: SUCCESS (0.003s)
[848.002858] [122/133] (176s left) gem_exec_whisper (basic-queues-forked)
[848.074391] Starting subtest: basic-queues-forked
[872.529616] Subtest basic-queues-forked: SUCCESS (24.448s)
[872.719248] [123/133] (151s left) i915_drm_fdinfo (busy-idle)
[872.763495] Starting subtest: busy-idle
[872.766108] Starting dynamic subtest: rcs0
[872.783601] Dynamic subtest rcs0: SKIP (0.022s)
[872.795998] Starting dynamic subtest: bcs0
[872.800459] Dynamic subtest bcs0: SKIP (0.000s)
[872.811007] Starting dynamic subtest: vcs0
[872.816236] Dynamic subtest vcs0: SKIP (0.000s)
[872.826567] Starting dynamic subtest: vcs1
[872.831331] Dynamic subtest vcs1: SKIP (0.000s)
[872.841572] Starting dynamic subtest: vecs0
[872.846568] Dynamic subtest vecs0: SKIP (0.000s)
[872.856448] Starting dynamic subtest: ccs0
[872.860739] Dynamic subtest ccs0: SKIP (0.000s)
[872.865277] Subtest busy-idle: SKIP (0.027s)
[872.904818] [124/133] (151s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[872.994068] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[872.996407] Starting dynamic subtest: pipe-A-eDP-1
[873.019436] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[873.031876] Starting dynamic subtest: pipe-B-eDP-1
[873.054995] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[873.065015] Starting dynamic subtest: pipe-C-eDP-1
[873.088599] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[873.099106] Starting dynamic subtest: pipe-D-eDP-1
[873.122279] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[873.126585] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[875.270025] [125/133] (149s left) kms_big_fb (linear-16bpp-rotate-0)
[875.371797] Starting subtest: linear-16bpp-rotate-0
[876.785157] Subtest linear-16bpp-rotate-0: SUCCESS (1.413s)
[876.908442] [126/133] (147s left) gem_exec_schedule (u-semaphore-resolve)
[876.982146] Starting subtest: u-semaphore-resolve
[877.013455] Subtest u-semaphore-resolve: SUCCESS (0.040s)
[877.350800] [127/133] (147s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[877.422458] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[877.425159] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[877.519516] [128/133] (147s left) perf_pmu (busy)
[877.566837] Starting subtest: busy
[877.569478] Starting dynamic subtest: rcs0
[878.154413] Dynamic subtest rcs0: SUCCESS (0.592s)
[878.170221] Starting dynamic subtest: bcs0
[878.719085] Dynamic subtest bcs0: SUCCESS (0.562s)
[878.732575] Starting dynamic subtest: vcs0
[880.622489] Dynamic subtest vcs0: SUCCESS (1.899s)
[880.636072] Starting dynamic subtest: vcs1
[882.668035] Dynamic subtest vcs1: SUCCESS (2.043s)
[882.686565] Starting dynamic subtest: vecs0
[884.652202] Dynamic subtest vecs0: SUCCESS (1.981s)
[884.666643] Starting dynamic subtest: ccs0
[885.222748] Dynamic subtest ccs0: SUCCESS (0.569s)
[885.225428] Subtest busy: SUCCESS (7.662s)
[885.318988] [129/133] (139s left) kms_chamelium_color (ctm-blue-to-red)
[885.417567] Subtest ctm-blue-to-red: SKIP (0.000s)
[885.472771] [130/133] (139s left) kms_content_protection (lic-type-0-hdcp14)
[885.622612] Starting subtest: lic-type-0-hdcp14
[885.628460] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[885.749239] [131/133] (139s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[885.862360] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[885.867419] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[885.959462] [132/133] (139s left) gem_ppgtt (flink-and-close-vma-leak)
[886.023102] Starting subtest: flink-and-close-vma-leak
[886.061933] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[886.185031] [133/133] (138s left) kms_cursor_crc (cursor-sliding-512x170)
[886.493270] Starting subtest: cursor-sliding-512x170
[886.497983] Subtest cursor-sliding-512x170: SKIP (0.001s)
[886.630059] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: sysfs_heartbeat_interval
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gem_ppgtt
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: core_getstats
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: gem_exec_alignment
results: parsing output: 17/ for test: gem_lmem_swapping
results: parsing output: 18/ for test: kms_prop_blob
results: parsing output: 19/ for test: kms_busy
results: parsing output: 20/ for test: gem_exec_await
results: parsing output: 21/ for test: kms_hdr
results: parsing output: 22/ for test: gem_ctx_param
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: vgem_basic
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_rotation_crc
results: parsing output: 28/ for test: sw_sync
results: parsing output: 29/ for test: kms_setmode
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_draw_crc
results: parsing output: 38/ for test: gem_render_linear_blits
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_color
results: parsing output: 43/ for test: kms_plane_alpha_blend
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_lease
results: parsing output: 47/ for test: gen7_exec_parse
results: parsing output: 48/ for test: gem_userptr_blits
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: prime_vgem
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: dmabuf_sync_file
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: gem_userptr_blits
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: i915_selftest
results: parsing output: 67/ for test: kms_pm_dc
results: parsing output: 68/ for test: kms_tiled_display
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_vm_create
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_vblank
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: fbdev
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_fbcon_fbt
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: gem_workarounds
results: parsing output: 92/ for test: i915_pm_rc6_residency
results: parsing output: 93/ for test: i915_module_load
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane_cursor
results: parsing output: 96/ for test: gem_exec_whisper
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_chamelium_frames
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_properties
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: kms_addfb_basic
results: parsing output: 104/ for test: gem_create
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_pipe_b_c_ivb
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_flink_basic
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_getfb
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_atomic
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: gem_exec_whisper
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_chamelium_color
results: parsing output: 129/ for test: kms_content_protection
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_ppgtt
results: parsing output: 132/ for test: kms_cursor_crc
Done.