[63.953225] Initializing watchdogs
[63.953292]   /dev/watchdog0
[63.974575] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.985773] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.989787] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.991963] [001/133] (960s left) kms_flip (wf_vblank-ts-check-interruptible)
[64.176498] Starting subtest: wf_vblank-ts-check-interruptible
[64.180948] Starting dynamic subtest: A-DP3
[72.315337] Dynamic subtest A-DP3: SUCCESS (8.134s)
[72.324386] Starting dynamic subtest: B-DP3
[80.348917] Dynamic subtest B-DP3: SUCCESS (8.033s)
[80.357639] Starting dynamic subtest: C-DP3
[88.384747] Dynamic subtest C-DP3: SUCCESS (8.035s)
[88.393465] Starting dynamic subtest: D-DP3
[96.415872] Dynamic subtest D-DP3: SUCCESS (8.030s)
[96.417653] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.241s)
[96.730818] [002/133] (927s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[96.925410] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[96.927162] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[97.038875] [003/133] (927s left) kms_plane (pixel-format-linear-modifier)
[97.218420] Starting subtest: pixel-format-linear-modifier
[97.262088] Starting dynamic subtest: pipe-A-plane-0
[103.212992] Dynamic subtest pipe-A-plane-0: SUCCESS (5.950s)
[103.242976] Starting dynamic subtest: pipe-A-plane-3
[106.312299] Dynamic subtest pipe-A-plane-3: SUCCESS (3.099s)
[106.321561] Starting dynamic subtest: pipe-A-plane-5
[106.529192] Dynamic subtest pipe-A-plane-5: SUCCESS (0.216s)
[106.808433] Starting dynamic subtest: pipe-B-plane-0
[112.811320] Dynamic subtest pipe-B-plane-0: SUCCESS (6.017s)
[112.820590] Starting dynamic subtest: pipe-B-plane-3
[116.045096] Dynamic subtest pipe-B-plane-3: SUCCESS (3.233s)
[116.054392] Starting dynamic subtest: pipe-B-plane-5
[116.261701] Dynamic subtest pipe-B-plane-5: SUCCESS (0.216s)
[116.353262] Subtest pixel-format-linear-modifier: SUCCESS (19.134s)
[116.666619] [004/133] (908s left) sysfs_heartbeat_interval (nopreempt)
[116.746849] Starting subtest: nopreempt
[116.747783] Starting dynamic subtest: vecs0
[121.054117] Dynamic subtest vecs0: SUCCESS (4.306s)
[121.063081] Starting dynamic subtest: ccs0
[125.294169] Dynamic subtest ccs0: SUCCESS (4.240s)
[125.302904] Starting dynamic subtest: vcs0
[129.516043] Dynamic subtest vcs0: SUCCESS (4.221s)
[129.524643] Starting dynamic subtest: bcs0
[133.695099] Dynamic subtest bcs0: SUCCESS (4.179s)
[133.703702] Starting dynamic subtest: vecs1
[137.921264] Dynamic subtest vecs1: SUCCESS (4.226s)
[137.930252] Starting dynamic subtest: rcs0
[142.238300] Dynamic subtest rcs0: SUCCESS (4.317s)
[142.247038] Starting dynamic subtest: vcs1
[146.447063] Dynamic subtest vcs1: SUCCESS (4.208s)
[146.448084] Subtest nopreempt: SUCCESS (29.700s)
[146.646187] [005/133] (878s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[146.837925] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[147.551254] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.713s)
[147.833763] [006/133] (877s left) kms_addfb_basic (bad-pitch-256)
[147.905111] Starting subtest: bad-pitch-256
[147.905956] Subtest bad-pitch-256: SUCCESS (0.000s)
[148.160774] [007/133] (876s left) kms_cursor_legacy (torture-move)
[148.340111] Starting subtest: torture-move
[148.340882] Starting dynamic subtest: pipe-A
[153.847119] Dynamic subtest pipe-A: SUCCESS (5.507s)
[153.856433] Starting dynamic subtest: pipe-B
[159.385424] Dynamic subtest pipe-B: SUCCESS (5.538s)
[159.395499] Starting dynamic subtest: pipe-C
[164.821432] Dynamic subtest pipe-C: SUCCESS (5.437s)
[164.842308] Starting dynamic subtest: pipe-D
[170.303345] Dynamic subtest pipe-D: SUCCESS (5.482s)
[170.312226] Starting dynamic subtest: all-pipes
[175.764820] Dynamic subtest all-pipes: SUCCESS (5.462s)
[175.765653] Subtest torture-move: SUCCESS (27.428s)
[175.866812] [008/133] (849s left) gem_ppgtt (shrink-vs-evict-any)
[175.970482] Starting subtest: shrink-vs-evict-any
[182.930508] Subtest shrink-vs-evict-any: SUCCESS (6.961s)
[183.021666] [009/133] (842s left) syncobj_timeline (wait-all-for-submit-snapshot)
[183.093283] Starting subtest: wait-all-for-submit-snapshot
[183.178470] Subtest wait-all-for-submit-snapshot: SUCCESS (0.084s)
[183.348297] [010/133] (841s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[183.530751] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[183.532431] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[183.671427] [011/133] (841s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[183.925164] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[184.089256] [012/133] (841s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[184.269564] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[184.271259] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[184.403442] [013/133] (840s left) gem_mmap_gtt (basic-write-read-distinct)
[184.474168] Subtest basic-write-read-distinct: SKIP (0.000s)
[184.540829] [014/133] (840s left) perf_pmu (busy-no-semaphores)
[184.603824] Starting subtest: busy-no-semaphores
[184.604731] Starting dynamic subtest: rcs0
[185.186395] Dynamic subtest rcs0: SUCCESS (0.581s)
[185.200390] Starting dynamic subtest: bcs0
[185.745031] Dynamic subtest bcs0: SUCCESS (0.556s)
[185.759226] Starting dynamic subtest: vcs0
[186.299560] Dynamic subtest vcs0: SUCCESS (0.552s)
[186.313589] Starting dynamic subtest: vcs1
[186.855113] Dynamic subtest vcs1: SUCCESS (0.553s)
[186.868605] Starting dynamic subtest: vecs0
[187.411466] Dynamic subtest vecs0: SUCCESS (0.554s)
[187.425387] Starting dynamic subtest: vecs1
[187.965622] Dynamic subtest vecs1: SUCCESS (0.552s)
[187.979608] Starting dynamic subtest: ccs0
[188.522526] Dynamic subtest ccs0: SUCCESS (0.555s)
[188.524465] Subtest busy-no-semaphores: SUCCESS (3.919s)
[188.678283] [015/133] (836s left) core_getstats (basic)
[188.754113] Starting subtest: basic
[188.754999] Subtest basic: SUCCESS (0.000s)
[188.898725] [016/133] (836s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[188.980925] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[188.983245] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[189.285902] [017/133] (836s left) gem_exec_alignment (pi)
[189.367069] Starting subtest: pi
[207.030369] Subtest pi: SUCCESS (17.665s)
[207.512994] [018/133] (818s left) gem_lmem_swapping (smem-oom)
[210.246014] Starting subtest: smem-oom
[210.246963] Starting dynamic subtest: lmem0
[241.325714] Dynamic subtest lmem0: SUCCESS (31.080s)
[241.329817] Subtest smem-oom: SUCCESS (31.082s)
[242.331401] [FACT gem_lmem_swapping (smem-oom)] deleted: kernel.kmod_is_loaded.i915: true
[242.335412] [019/133] (783s left) kms_prop_blob (blob-prop-lifetime)
[244.044364] Starting subtest: blob-prop-lifetime
[244.070366] Subtest blob-prop-lifetime: SUCCESS (0.026s)
[244.217428] [FACT kms_prop_blob (blob-prop-lifetime)] new: kernel.kmod_is_loaded.i915: true
[244.220017] [020/133] (781s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[244.433259] Starting subtest: extended-modeset-hang-oldfb-with-reset
[244.435114] Starting dynamic subtest: pipe-A
[255.394966] Dynamic subtest pipe-A: SUCCESS (10.959s)
[255.419025] Starting dynamic subtest: pipe-D
[266.068270] Dynamic subtest pipe-D: SUCCESS (10.669s)
[266.069265] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.637s)
[266.308691] [021/133] (759s left) gem_exec_await (wide-all)
[266.601101] Starting subtest: wide-all
[288.541487] Subtest wide-all: SUCCESS (21.942s)
[288.791505] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true
[288.794069] [022/133] (737s left) kms_hdr (static-toggle-suspend)
[289.034599] Starting subtest: static-toggle-suspend
[292.573624] Starting dynamic subtest: pipe-A-DP-3
[312.387102] Dynamic subtest pipe-A-DP-3: SUCCESS (4.789s)
[312.388634] Subtest static-toggle-suspend: SUCCESS (8.328s)
[330.747471] [023/133] (713s left) gem_ctx_param (vm)
[330.832872] Starting subtest: vm
[330.924021] Subtest vm: SUCCESS (0.091s)
[331.143850] [024/133] (713s left) gem_mmap_gtt (big-copy-odd)
[331.221366] Subtest big-copy-odd: SKIP (0.000s)
[331.298655] [025/133] (712s left) kms_cursor_crc (cursor-random-128x128)
[331.674340] Starting subtest: cursor-random-128x128
[331.677727] Starting dynamic subtest: pipe-A-DP-3
[336.438603] Dynamic subtest pipe-A-DP-3: SUCCESS (4.634s)
[336.489241] Starting dynamic subtest: pipe-D-DP-3
[341.046741] Dynamic subtest pipe-D-DP-3: SUCCESS (4.505s)
[341.047676] Subtest cursor-random-128x128: SUCCESS (9.180s)
[341.468887] [026/133] (702s left) vgem_basic (unload)
[341.519434] Starting subtest: unload
[370.526141] Subtest unload: SUCCESS (28.924s)
[370.660686] [027/133] (673s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[370.862338] Starting subtest: x-tiled-8bpp-rotate-90
[370.922591] Subtest x-tiled-8bpp-rotate-90: SKIP (0.060s)
[371.113989] [028/133] (673s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[371.304152] Starting subtest: multiplane-rotation-cropping-top
[400.773425] Subtest multiplane-rotation-cropping-top: SUCCESS (29.455s)
[400.975847] [029/133] (643s left) sw_sync (alloc_fence_invalid_timeline)
[401.037474] Starting subtest: alloc_fence_invalid_timeline
[401.038401] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[401.122503] [030/133] (643s left) kms_setmode (invalid-clone-exclusive-crtc)
[401.204025] Starting subtest: invalid-clone-exclusive-crtc
[401.206670] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[401.382170] [031/133] (643s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[401.463706] Starting subtest: etime-multi-wait-all-available-unsubmitted
[401.569705] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.105s)
[401.743107] [032/133] (643s left) gem_mmap_gtt (big-bo-tiledx)
[401.826500] Subtest big-bo-tiledX: SKIP (0.000s)
[401.903847] [033/133] (642s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[402.098696] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[402.099623] Starting dynamic subtest: pipe-A-DP-3
[402.107937] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[402.122646] Starting dynamic subtest: pipe-B-DP-3
[402.131059] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[402.145561] Starting dynamic subtest: pipe-C-DP-3
[402.153726] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[402.168459] Starting dynamic subtest: pipe-D-DP-3
[402.179294] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[402.181582] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.010s)
[402.573932] [034/133] (642s left) gem_userptr_blits (readonly-unsync)
[402.662444] Subtest readonly-unsync: SKIP (0.000s)
[402.891776] [035/133] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[403.081617] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[403.083317] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[403.293725] [036/133] (641s left) syncobj_wait (multi-wait-for-submit-submitted)
[403.378698] Starting subtest: multi-wait-for-submit-submitted
[403.480727] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s)
[403.642190] [037/133] (641s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[403.716722] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[403.831454] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[404.026348] [038/133] (641s left) kms_draw_crc (draw-method-mmap-wc)
[404.218725] Starting subtest: draw-method-mmap-wc
[404.220503] Subtest draw-method-mmap-wc: SKIP (0.000s)
[404.408019] [039/133] (641s left) gem_render_linear_blits (basic)
[404.490398] Starting subtest: basic
[404.562750] Subtest basic: SUCCESS (0.072s)
[404.680200] [040/133] (640s left) kms_pm_rpm (fences-dpms)
[407.100845] Starting subtest: fences-dpms
[407.102675] Subtest fences-dpms: SKIP (0.000s)
[407.428856] [041/133] (638s left) kms_cursor_crc (cursor-dpms)
[407.688597] Starting subtest: cursor-dpms
[407.690889] Starting dynamic subtest: pipe-A-DP-3
[408.967889] Dynamic subtest pipe-A-DP-3: SUCCESS (1.277s)
[408.990144] Starting dynamic subtest: pipe-D-DP-3
[410.143763] Dynamic subtest pipe-D-DP-3: SUCCESS (1.173s)
[410.144676] Subtest cursor-dpms: SUCCESS (2.454s)
[410.676180] [042/133] (634s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[410.868557] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[410.869294] Starting dynamic subtest: pipe-A
[410.966388] Dynamic subtest pipe-A: SUCCESS (0.098s)
[410.990055] Starting dynamic subtest: pipe-B
[411.195992] Dynamic subtest pipe-B: SUCCESS (0.228s)
[411.212698] Starting dynamic subtest: pipe-C
[411.392341] Dynamic subtest pipe-C: SUCCESS (0.195s)
[411.419422] Starting dynamic subtest: pipe-D
[411.605387] Dynamic subtest pipe-D: SUCCESS (0.211s)
[411.606483] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.738s)
[411.920173] [043/133] (633s left) kms_color (ctm-blue-to-red)
[412.109034] Starting subtest: ctm-blue-to-red
[412.109901] Starting dynamic subtest: pipe-A-DP-3
[412.785827] Dynamic subtest pipe-A-DP-3: SUCCESS (0.674s)
[412.814439] Starting dynamic subtest: pipe-B-DP-3
[413.404780] Dynamic subtest pipe-B-DP-3: SUCCESS (0.617s)
[413.422299] Starting dynamic subtest: pipe-C-DP-3
[413.978742] Dynamic subtest pipe-C-DP-3: SUCCESS (0.572s)
[413.995512] Starting dynamic subtest: pipe-D-DP-3
[414.618129] Dynamic subtest pipe-D-DP-3: SUCCESS (0.636s)
[414.619589] Subtest ctm-blue-to-red: SUCCESS (2.507s)
[414.872337] [044/133] (630s left) kms_plane_alpha_blend (constant-alpha-min)
[415.060170] Starting subtest: constant-alpha-min
[415.309060] Starting dynamic subtest: pipe-A-DP-3
[416.016168] Dynamic subtest pipe-A-DP-3: SUCCESS (0.707s)
[416.033527] Starting dynamic subtest: pipe-D-DP-3
[416.776174] Dynamic subtest pipe-D-DP-3: SUCCESS (0.757s)
[416.777138] Subtest constant-alpha-min: SUCCESS (1.716s)
[417.040815] [045/133] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[417.236430] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[417.238114] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[417.388256] [046/133] (628s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[417.574240] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[417.576690] Starting dynamic subtest: pipe-A-DP-3
[417.585268] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[417.600293] Starting dynamic subtest: pipe-B-DP-3
[417.608775] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[417.623495] Starting dynamic subtest: pipe-C-DP-3
[417.631778] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[417.646750] Starting dynamic subtest: pipe-D-DP-3
[417.656602] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[417.658665] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.010s)
[418.047360] [047/133] (628s left) kms_lease (lease-uevent)
[418.234747] Starting subtest: lease-uevent
[419.253686] Subtest lease-uevent: SUCCESS (1.019s)
[419.396690] [048/133] (626s left) gen7_exec_parse (oacontrol-tracking)
[419.481329] Subtest oacontrol-tracking: SKIP (0.000s)
[419.551965] [049/133] (626s left) gem_userptr_blits (unsync-unmap-cycles)
[419.640246] Subtest unsync-unmap-cycles: SKIP (0.000s)
[419.846917] [050/133] (626s left) kms_flip (basic-flip-vs-modeset)
[420.031825] Starting subtest: basic-flip-vs-modeset
[420.036666] Starting dynamic subtest: A-DP3
[420.903475] Dynamic subtest A-DP3: SUCCESS (0.863s)
[420.934292] Starting dynamic subtest: B-DP3
[421.732155] Dynamic subtest B-DP3: SUCCESS (0.825s)
[421.759242] Starting dynamic subtest: C-DP3
[422.545448] Dynamic subtest C-DP3: SUCCESS (0.808s)
[422.576322] Starting dynamic subtest: D-DP3
[423.368720] Dynamic subtest D-DP3: SUCCESS (0.822s)
[423.371622] Subtest basic-flip-vs-modeset: SUCCESS (3.338s)
[423.648198] [051/133] (622s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[423.726742] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[423.727706] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[423.925915] [052/133] (622s left) syncobj_timeline (reset-during-wait-for-submit)
[424.004408] Starting subtest: reset-during-wait-for-submit
[424.106078] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[424.303135] [053/133] (622s left) perf (buffer-fill)
[424.690421] Starting subtest: buffer-fill
[424.691293] Starting dynamic subtest: 0-rcs0
[426.868645] Dynamic subtest 0-rcs0: SUCCESS (2.178s)
[426.869622] Subtest buffer-fill: SUCCESS (2.179s)
[426.928791] [054/133] (619s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[427.124476] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[430.225497] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.102s)
[430.514070] [055/133] (616s left) prime_vgem (wait)
[430.613696] Starting subtest: wait
[430.614745] Starting dynamic subtest: rcs0
[430.683190] Dynamic subtest rcs0: SUCCESS (0.068s)
[430.702686] Starting dynamic subtest: bcs0
[430.739694] Dynamic subtest bcs0: SUCCESS (0.057s)
[430.759891] Starting dynamic subtest: vcs0
[430.780560] Dynamic subtest vcs0: SUCCESS (0.040s)
[430.800745] Starting dynamic subtest: vcs1
[430.819706] Dynamic subtest vcs1: SUCCESS (0.038s)
[430.839842] Starting dynamic subtest: vecs0
[430.860341] Dynamic subtest vecs0: SUCCESS (0.039s)
[430.880452] Starting dynamic subtest: vecs1
[430.901229] Dynamic subtest vecs1: SUCCESS (0.039s)
[430.921452] Starting dynamic subtest: ccs0
[430.943155] Dynamic subtest ccs0: SUCCESS (0.041s)
[430.944136] Subtest wait: SUCCESS (0.332s)
[431.132063] [056/133] (615s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[431.336828] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[432.625022] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.287s)
[432.867003] [057/133] (614s left) gem_exec_fence (syncobj-timeline-unused-fence)
[433.520638] Starting subtest: syncobj-timeline-unused-fence
[433.551828] Subtest syncobj-timeline-unused-fence: SUCCESS (0.036s)
[433.861232] [058/133] (613s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[434.050700] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[434.051575] Starting dynamic subtest: pipe-A-valid-mode
[435.838910] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.786s)
[435.840300] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (1.790s)
[436.106687] [059/133] (610s left) kms_psr (pr-basic)
[436.295142] Subtest pr-basic: SKIP (0.000s)
[436.360060] [060/133] (610s left) dmabuf_sync_file (export-wait-after-attach)
[436.427180] Starting subtest: export-wait-after-attach
[436.428165] Subtest export-wait-after-attach: SUCCESS (0.001s)
[436.531009] [061/133] (610s left) gem_exec_balancer (busy)
[436.622688] Starting subtest: busy
[437.537647] Subtest busy: SUCCESS (0.915s)
[437.951250] [062/133] (609s left) gem_userptr_blits (dmabuf-unsync)
[438.040255] Subtest dmabuf-unsync: SKIP (0.000s)
[438.235951] [063/133] (609s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[438.424178] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[438.812666] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.388s)
[439.089874] [064/133] (608s left) gem_render_copy (yf-tiled-ccs-to-linear)
[439.178531] Starting subtest: yf-tiled-ccs-to-linear
[439.180666] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[439.479166] [065/133] (608s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[439.675326] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[439.737016] [066/133] (607s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[439.927422] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[439.987318] [067/133] (607s left) i915_selftest (mock)
[441.004206] Starting subtest: mock
[441.005164] Starting dynamic subtest: sanitycheck
[441.822319] Dynamic subtest sanitycheck: SUCCESS (0.818s)
[441.854250] Starting dynamic subtest: shmem
[442.634010] Dynamic subtest shmem: SUCCESS (0.809s)
[442.652985] Starting dynamic subtest: fence
[451.028299] Dynamic subtest fence: SUCCESS (8.392s)
[451.043299] Starting dynamic subtest: scatterlist
[452.830018] Dynamic subtest scatterlist: SUCCESS (1.800s)
[452.842462] Starting dynamic subtest: syncmap
[455.684455] Dynamic subtest syncmap: SUCCESS (2.854s)
[455.700185] Starting dynamic subtest: uncore
[456.504915] Dynamic subtest uncore: SUCCESS (0.817s)
[456.544326] Starting dynamic subtest: ring
[457.331892] Dynamic subtest ring: SUCCESS (0.821s)
[457.376285] Starting dynamic subtest: engine
[458.159787] Dynamic subtest engine: SUCCESS (0.825s)
[458.194725] Starting dynamic subtest: timelines
[462.772119] Dynamic subtest timelines: SUCCESS (4.610s)
[462.786381] Starting dynamic subtest: requests
[466.066331] Dynamic subtest requests: SUCCESS (3.292s)
[466.111681] Starting dynamic subtest: objects
[467.037286] Dynamic subtest objects: SUCCESS (0.967s)
[467.052554] Starting dynamic subtest: phys
[467.956135] Dynamic subtest phys: SUCCESS (0.917s)
[467.970030] Starting dynamic subtest: dmabuf
[468.890460] Dynamic subtest dmabuf: SUCCESS (0.933s)
[468.904945] Starting dynamic subtest: vma
[477.103297] Dynamic subtest vma: SUCCESS (8.210s)
[477.115573] Starting dynamic subtest: evict
[478.923146] Dynamic subtest evict: SUCCESS (1.818s)
[478.935693] Starting dynamic subtest: gtt
[482.871090] Dynamic subtest gtt: SUCCESS (3.946s)
[482.885627] Starting dynamic subtest: hugepages
[483.945957] Dynamic subtest hugepages: SUCCESS (1.073s)
[483.958965] Starting dynamic subtest: memory_region
[487.345079] Dynamic subtest memory_region: SUCCESS (3.397s)
[487.346063] Subtest mock: SUCCESS (46.339s)
[487.385304] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[487.386389] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[487.388502] [068/133] (560s left) kms_pm_dc (dc5-dpms)
[490.048565] Starting subtest: dc5-dpms
[491.501269] Subtest dc5-dpms: SUCCESS (1.453s)
[491.744885] [FACT kms_pm_dc (dc5-dpms)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[491.747125] [FACT kms_pm_dc (dc5-dpms)] new: kernel.kmod_is_loaded.i915: true
[491.750080] [069/133] (555s left) kms_tiled_display (basic-test-pattern)
[492.006730] Subtest basic-test-pattern: SKIP (0.000s)
[492.075240] [070/133] (555s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[492.268217] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[492.269964] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[492.427835] [071/133] (555s left) gem_vm_create (execbuf)
[492.520399] Starting subtest: execbuf
[492.532558] Subtest execbuf: SUCCESS (0.012s)
[492.696944] [072/133] (555s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[492.890693] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[492.892426] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[493.044425] [073/133] (554s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[493.238223] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[496.429018] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.190s)
[496.588695] [074/133] (551s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[496.781228] Starting subtest: pipe-fbc-rte
[496.786176] Subtest pipe-fbc-rte: SKIP (0.000s)
[496.925024] [075/133] (551s left) gem_userptr_blits (sync-unmap)
[497.024820] Starting subtest: sync-unmap
[497.051066] Subtest sync-unmap: SUCCESS (0.026s)
[497.219080] [076/133] (551s left) gem_exec_balancer (sliced)
[497.311447] Starting subtest: sliced
[497.313446] Subtest sliced: SKIP (0.000s)
[497.733881] [077/133] (550s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[497.919230] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[497.932989] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.014s)
[498.033610] [078/133] (550s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[498.113736] Starting subtest: invalid-signal-one-illegal-handle
[498.114654] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[498.323410] [079/133] (550s left) kms_vblank (wait-busy)
[498.509715] Starting subtest: wait-busy
[498.510605] Starting dynamic subtest: pipe-A-DP-3
[501.048785] Dynamic subtest pipe-A-DP-3: SUCCESS (2.536s)
[501.084667] Starting dynamic subtest: pipe-D-DP-3
[503.515835] Dynamic subtest pipe-D-DP-3: SUCCESS (2.456s)
[503.516844] Subtest wait-busy: SUCCESS (5.006s)
[503.754065] [080/133] (544s left) kms_psr (psr2-dpms)
[503.944220] Subtest psr2-dpms: SKIP (0.000s)
[504.005566] [081/133] (544s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[504.198365] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[504.200112] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[504.330822] [082/133] (544s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[504.524650] Starting subtest: cursorB-vs-flipB-toggle
[504.526468] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[504.645522] [083/133] (544s left) kms_addfb_basic (bad-pitch-65536)
[504.725163] Starting subtest: bad-pitch-65536
[504.726031] Subtest bad-pitch-65536: SUCCESS (0.000s)
[504.960938] [084/133] (543s left) fbdev (eof)
[505.024467] Starting subtest: eof
[505.025427] Subtest eof: SUCCESS (0.000s)
[505.130393] [085/133] (543s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[505.317718] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[505.318609] Starting dynamic subtest: pipe-A-DP-3
[505.327872] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[505.342050] Starting dynamic subtest: pipe-B-DP-3
[505.351390] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[505.365379] Starting dynamic subtest: pipe-C-DP-3
[505.374326] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[505.388312] Starting dynamic subtest: pipe-D-DP-3
[505.399795] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[505.401799] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[505.777700] [086/133] (543s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[505.866602] Starting subtest: legacy-engines-hostile-preempt
[505.867478] Starting dynamic subtest: render
[505.959490] Dynamic subtest render: SUCCESS (0.092s)
[505.977554] Starting dynamic subtest: bsd1
[506.003709] Dynamic subtest bsd1: SUCCESS (0.043s)
[506.024487] Starting dynamic subtest: bsd2
[506.047509] Dynamic subtest bsd2: SUCCESS (0.042s)
[506.070445] Starting dynamic subtest: blt
[506.099722] Dynamic subtest blt: SUCCESS (0.050s)
[506.129080] Starting dynamic subtest: vebox
[506.132126] Dynamic subtest vebox: SUCCESS (0.030s)
[506.133259] Subtest legacy-engines-hostile-preempt: SUCCESS (0.266s)
[506.302161] [087/133] (542s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[506.507322] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[506.509175] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[506.649301] [088/133] (542s left) gem_exec_schedule (in-order)
[506.745332] Starting subtest: in-order
[506.746308] Starting dynamic subtest: rcs0
[507.042393] Dynamic subtest rcs0: SUCCESS (0.288s)
[507.057666] Starting dynamic subtest: bcs0
[507.248405] Dynamic subtest bcs0: SUCCESS (0.204s)
[507.262825] Starting dynamic subtest: vcs0
[507.464624] Dynamic subtest vcs0: SUCCESS (0.218s)
[507.478878] Starting dynamic subtest: vcs1
[507.672433] Dynamic subtest vcs1: SUCCESS (0.212s)
[507.687448] Starting dynamic subtest: vecs0
[507.898070] Dynamic subtest vecs0: SUCCESS (0.224s)
[507.912684] Starting dynamic subtest: vecs1
[508.103416] Dynamic subtest vecs1: SUCCESS (0.204s)
[508.117814] Starting dynamic subtest: ccs0
[508.316238] Dynamic subtest ccs0: SUCCESS (0.211s)
[508.317275] Subtest in-order: SUCCESS (1.571s)
[508.724433] [089/133] (540s left) kms_psr (fbc-psr-primary-mmap-cpu)
[508.914468] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[508.985195] [090/133] (540s left) kms_fbcon_fbt (fbc-suspend)
[509.074835] Starting subtest: fbc-suspend
[561.487718] Subtest fbc-suspend: SUCCESS (21.122s)
[575.640630] [091/133] (487s left) kms_plane_scaling (invalid-num-scalers)
[575.851737] Starting subtest: invalid-num-scalers
[575.858843] Starting dynamic subtest: pipe-A-DP-3-invalid-num-scalers
[575.882838] Dynamic subtest pipe-A-DP-3-invalid-num-scalers: SUCCESS (0.023s)
[575.905077] Starting dynamic subtest: pipe-B-DP-3-invalid-num-scalers
[575.929677] Dynamic subtest pipe-B-DP-3-invalid-num-scalers: SUCCESS (0.038s)
[575.951730] Starting dynamic subtest: pipe-C-DP-3-invalid-num-scalers
[575.977724] Dynamic subtest pipe-C-DP-3-invalid-num-scalers: SUCCESS (0.038s)
[575.999365] Starting dynamic subtest: pipe-D-DP-3-invalid-num-scalers
[576.024988] Dynamic subtest pipe-D-DP-3-invalid-num-scalers: SUCCESS (0.038s)
[576.025738] Subtest invalid-num-scalers: SUCCESS (0.168s)
[576.163164] [092/133] (487s left) gem_workarounds (reset-fd)
[576.265968] Starting subtest: reset-fd
[576.505992] Subtest reset-fd: SUCCESS (0.232s)
[576.657932] [093/133] (486s left) i915_pm_rc6_residency (rc6-idle)
[576.741382] Starting subtest: rc6-idle
[576.761999] Starting dynamic subtest: gt0-rcs0
[601.263231] Dynamic subtest gt0-rcs0: SUCCESS (24.271s)
[601.282643] Starting dynamic subtest: gt0-bcs0
[625.639024] Dynamic subtest gt0-bcs0: SUCCESS (24.360s)
[625.656248] Starting dynamic subtest: gt0-vcs0
[649.879873] Dynamic subtest gt0-vcs0: SUCCESS (24.230s)
[649.898651] Starting dynamic subtest: gt0-vecs0
[674.273838] Dynamic subtest gt0-vecs0: SUCCESS (24.382s)
[674.291119] Starting dynamic subtest: gt0-ccs0
[698.640801] Dynamic subtest gt0-ccs0: SUCCESS (24.372s)
[698.643095] Subtest rc6-idle: SUCCESS (121.648s)
[698.838355] [094/133] (364s left) i915_module_load (reload-no-display)
[698.887427] Starting subtest: reload-no-display
[704.566482] Subtest reload-no-display: SUCCESS (5.679s)
[704.600528] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[704.601510] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[704.603343] [095/133] (358s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[706.336644] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[709.234594] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.898s)
[709.486739] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[709.489317] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)] new: kernel.kmod_is_loaded.i915: true
[709.491958] [096/133] (354s left) kms_plane_cursor (viewport)
[709.682251] Starting subtest: viewport
[709.683955] Starting dynamic subtest: pipe-A-DP-3-size-64
[712.934787] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.250s)
[713.025545] Starting dynamic subtest: pipe-A-DP-3-size-128
[716.301543] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.299s)
[716.381966] Starting dynamic subtest: pipe-A-DP-3-size-256
[719.568018] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.200s)
[719.747882] Starting dynamic subtest: pipe-B-DP-3-size-64
[723.020398] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.288s)
[723.084642] Starting dynamic subtest: pipe-B-DP-3-size-128
[726.304231] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.233s)
[726.381625] Starting dynamic subtest: pipe-B-DP-3-size-256
[729.521287] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.166s)
[729.666542] Starting dynamic subtest: pipe-C-DP-3-size-64
[732.900270] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.250s)
[732.974330] Starting dynamic subtest: pipe-C-DP-3-size-128
[736.117544] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.166s)
[736.191940] Starting dynamic subtest: pipe-C-DP-3-size-256
[739.384095] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.216s)
[739.530201] Starting dynamic subtest: pipe-D-DP-3-size-64
[742.632812] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.119s)
[742.710976] Starting dynamic subtest: pipe-D-DP-3-size-128
[745.900443] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.216s)
[745.974863] Starting dynamic subtest: pipe-D-DP-3-size-256
[749.134761] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.183s)
[749.245302] Subtest viewport: SUCCESS (39.556s)
[749.500109] [097/133] (314s left) gem_exec_whisper (basic-fds-forked)
[749.601048] Starting subtest: basic-fds-forked
[772.680781] Subtest basic-fds-forked: SUCCESS (23.072s)
[772.929204] [098/133] (290s left) gem_mmap_gtt (zero-extend)
[773.008698] Subtest zero-extend: SKIP (0.000s)
[773.078549] [099/133] (290s left) kms_chamelium_frames (dp-crc-single)
[773.354619] Subtest dp-crc-single: SKIP (0.000s)
[773.510989] [100/133] (290s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[773.705052] Starting subtest: psr-rgb101010-draw-mmap-wc
[773.706703] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[773.842846] [101/133] (290s left) gem_exec_reloc (basic-gtt-read-noreloc)
[773.931125] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[774.016294] [102/133] (290s left) kms_properties (get_properties-sanity-atomic)
[774.207937] Starting subtest: get_properties-sanity-atomic
[774.210128] Subtest get_properties-sanity-atomic: SUCCESS (0.004s)
[774.307574] [103/133] (289s left) gem_softpin (evict-single-offset)
[774.393810] Starting subtest: evict-single-offset
[806.559443] Subtest evict-single-offset: SUCCESS (32.160s)
[806.694690] [104/133] (257s left) kms_addfb_basic (invalid-set-prop-any)
[806.838621] Starting subtest: invalid-set-prop-any
[806.839687] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[807.075936] [105/133] (257s left) gem_create (create-massive)
[807.167878] Starting subtest: create-massive
[807.168757] Subtest create-massive: SUCCESS (0.000s)
[807.374995] [106/133] (256s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[807.565527] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[807.567362] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[807.697577] [107/133] (256s left) kms_flip (2x-flip-vs-suspend-interruptible)
[807.893036] Starting subtest: 2x-flip-vs-suspend-interruptible
[807.908619] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.015s)
[808.021425] [108/133] (256s left) gem_exec_fence (syncobj-channel)
[808.583835] Starting subtest: syncobj-channel
[809.604354] Subtest syncobj-channel: SUCCESS (1.020s)
[809.984660] [109/133] (254s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[810.180634] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[812.305360] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (2.126s)
[812.513335] [110/133] (252s left) gem_eio (in-flight-contexts-immediate)
[812.815469] Starting subtest: in-flight-contexts-immediate
[826.251720] Subtest in-flight-contexts-immediate: SUCCESS (13.441s)
[826.487457] [111/133] (238s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[826.568632] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[826.663959] [112/133] (238s left) kms_async_flips (async-flip-hang)
[826.854751] Starting subtest: async-flip-hang
[827.083960] Starting dynamic subtest: pipe-A-DP-3
[829.856950] Dynamic subtest pipe-A-DP-3: SUCCESS (2.773s)
[830.083584] Starting dynamic subtest: pipe-B-DP-3
[832.651997] Dynamic subtest pipe-B-DP-3: SUCCESS (2.585s)
[832.840979] Starting dynamic subtest: pipe-C-DP-3
[835.414426] Dynamic subtest pipe-C-DP-3: SUCCESS (2.589s)
[835.626024] Starting dynamic subtest: pipe-D-DP-3
[838.187335] Dynamic subtest pipe-D-DP-3: SUCCESS (2.577s)
[838.188173] Subtest async-flip-hang: SUCCESS (11.336s)
[838.635761] [113/133] (226s left) kms_psr (fbc-pr-sprite-render)
[838.825718] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[838.900315] [114/133] (226s left) gem_flink_basic (bad-open)
[838.981055] Starting subtest: bad-open
[838.982027] Subtest bad-open: SUCCESS (0.000s)
[839.138610] [115/133] (225s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[839.330356] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[839.331972] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[839.454040] [116/133] (225s left) kms_getfb (getfb2-handle-closed)
[839.642914] Starting subtest: getfb2-handle-closed
[839.643787] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[839.846390] [117/133] (225s left) gem_exec_params (no-vebox)
[839.934898] Starting subtest: no-vebox
[839.937170] Subtest no-vebox: SUCCESS (0.001s)
[840.159831] [118/133] (225s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[840.353372] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[840.355063] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[840.491822] [119/133] (224s left) kms_atomic (plane-immutable-zpos)
[840.679035] Starting subtest: plane-immutable-zpos
[840.681626] Starting dynamic subtest: pipe-A-DP-3
[841.608204] Dynamic subtest pipe-A-DP-3: SUCCESS (0.928s)
[841.609071] Subtest plane-immutable-zpos: SUCCESS (0.930s)
[841.885103] [120/133] (223s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[842.076716] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[842.078405] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[842.246314] [121/133] (223s left) api_intel_allocator (alloc-simple)
[842.329112] Starting subtest: alloc-simple
[842.355029] Subtest alloc-simple: SUCCESS (0.027s)
[842.532842] [122/133] (223s left) gem_exec_whisper (basic-queues-forked)
[842.628476] Starting subtest: basic-queues-forked
[865.065566] Subtest basic-queues-forked: SUCCESS (22.436s)
[865.318693] [123/133] (200s left) i915_drm_fdinfo (busy-idle)
[865.390949] Starting subtest: busy-idle
[865.391861] Starting dynamic subtest: rcs0
[865.393656] Dynamic subtest rcs0: SKIP (0.000s)
[865.410460] Starting dynamic subtest: bcs0
[865.412411] Dynamic subtest bcs0: SKIP (0.001s)
[865.429558] Starting dynamic subtest: vcs0
[865.431967] Dynamic subtest vcs0: SKIP (0.000s)
[865.448679] Starting dynamic subtest: vcs1
[865.450975] Dynamic subtest vcs1: SKIP (0.000s)
[865.468100] Starting dynamic subtest: vecs0
[865.470362] Dynamic subtest vecs0: SKIP (0.012s)
[865.486650] Starting dynamic subtest: vecs1
[865.489068] Dynamic subtest vecs1: SKIP (0.000s)
[865.505169] Starting dynamic subtest: ccs0
[865.507185] Dynamic subtest ccs0: SKIP (0.000s)
[865.509205] Subtest busy-idle: SKIP (0.022s)
[865.561926] [124/133] (200s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[865.747854] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[865.748753] Starting dynamic subtest: pipe-A-DP-3
[865.757138] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[865.773925] Starting dynamic subtest: pipe-B-DP-3
[865.782427] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[865.798736] Starting dynamic subtest: pipe-C-DP-3
[865.807813] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[865.827687] Starting dynamic subtest: pipe-D-DP-3
[865.838675] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[865.840638] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[866.217810] [125/133] (199s left) kms_big_fb (linear-16bpp-rotate-0)
[866.423043] Starting subtest: linear-16bpp-rotate-0
[868.330350] Subtest linear-16bpp-rotate-0: SUCCESS (1.906s)
[868.560532] [126/133] (197s left) gem_exec_schedule (u-semaphore-resolve)
[868.660043] Starting subtest: u-semaphore-resolve
[868.746589] Subtest u-semaphore-resolve: SUCCESS (0.086s)
[869.236403] [127/133] (196s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[869.317915] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[869.318839] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[869.463370] [128/133] (196s left) perf_pmu (busy)
[869.534985] Starting subtest: busy
[869.535917] Starting dynamic subtest: rcs0
[870.153633] Dynamic subtest rcs0: SUCCESS (0.618s)
[870.174257] Starting dynamic subtest: bcs0
[870.717568] Dynamic subtest bcs0: SUCCESS (0.562s)
[870.738524] Starting dynamic subtest: vcs0
[871.281674] Dynamic subtest vcs0: SUCCESS (0.562s)
[871.302329] Starting dynamic subtest: vcs1
[871.844104] Dynamic subtest vcs1: SUCCESS (0.560s)
[871.865397] Starting dynamic subtest: vecs0
[872.407001] Dynamic subtest vecs0: SUCCESS (0.557s)
[872.428358] Starting dynamic subtest: vecs1
[872.970178] Dynamic subtest vecs1: SUCCESS (0.558s)
[872.990998] Starting dynamic subtest: ccs0
[873.530999] Dynamic subtest ccs0: SUCCESS (0.555s)
[873.534109] Subtest busy: SUCCESS (3.998s)
[873.695409] [129/133] (192s left) kms_chamelium_color (ctm-blue-to-red)
[873.882634] Subtest ctm-blue-to-red: SKIP (0.000s)
[873.947393] [130/133] (192s left) kms_content_protection (lic-type-0-hdcp14)
[874.201923] Starting subtest: lic-type-0-hdcp14
[874.229590] Starting dynamic subtest: pipe-A-DP-3
[996.351627] Dynamic subtest pipe-A-DP-3: FAIL (121.941s)
[996.352742] Subtest lic-type-0-hdcp14: FAIL (122.070s)
[996.559384] [131/133] ( 69s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[996.752760] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[996.754476] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[996.896509] [132/133] ( 69s left) gem_ppgtt (flink-and-close-vma-leak)
[996.982364] Starting subtest: flink-and-close-vma-leak
[997.058788] Subtest flink-and-close-vma-leak: SUCCESS (0.076s)
[997.242131] [133/133] ( 69s left) kms_cursor_crc (cursor-sliding-512x170)
[997.730427] Starting subtest: cursor-sliding-512x170
[997.732332] Subtest cursor-sliding-512x170: SKIP (0.001s)
[997.915016] 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.