[59.893623] Initializing watchdogs
[59.893672]   /dev/watchdog0
[59.907658] [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]
[59.912111] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.915020] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.918548] [001/133] (960s left) prime_self_import (basic-llseek-size)
[59.978935] Starting subtest: basic-llseek-size
[60.005825] Subtest basic-llseek-size: SUCCESS (0.029s)
[60.124480] [002/133] (960s left) syncobj_wait (single-wait-all-submitted)
[60.180730] Starting subtest: single-wait-all-submitted
[60.290341] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[60.379110] [003/133] (960s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[60.439069] Starting subtest: yf-tiled-to-vebox-y-tiled
[60.443789] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[60.634741] [004/133] (959s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[60.743926] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[61.823438] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.078s)
[61.954950] [005/133] (958s left) kms_psr (psr2-sprite-plane-move)
[62.043474] Starting subtest: psr2-sprite-plane-move
[62.045468] Starting dynamic subtest: eDP-1
[63.787020] Dynamic subtest eDP-1: SUCCESS (1.740s)
[63.789758] Subtest psr2-sprite-plane-move: SUCCESS (1.741s)
[64.626845] [006/133] (955s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[64.717733] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[64.720148] Starting dynamic subtest: pipe-A-eDP-1
[64.792887] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[64.800733] Starting dynamic subtest: pipe-B-eDP-1
[65.901194] Dynamic subtest pipe-B-eDP-1: SKIP (1.106s)
[65.905916] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.185s)
[67.117517] [007/133] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[67.380574] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[74.709877] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.330s)
[74.833598] [008/133] (945s left) kms_rotation_crc (exhaust-fences)
[74.928068] Starting subtest: exhaust-fences
[74.932208] Subtest exhaust-fences: SKIP (0.000s)
[74.999381] [009/133] (945s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[75.046651] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[75.154076] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[75.244555] [010/133] (945s left) gem_tiled_blits (interruptible)
[75.309299] Subtest interruptible: SKIP (0.000s)
[75.367235] [011/133] (945s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[75.454145] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[75.456452] Starting dynamic subtest: pipe-A-eDP-1
[82.131266] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.678s)
[82.140224] Starting dynamic subtest: pipe-B-eDP-1
[88.976376] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.830s)
[88.986674] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.511s)
[89.830500] [012/133] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[89.923573] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[97.310651] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.388s)
[97.445742] [013/133] (923s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[97.542856] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[97.544995] Starting dynamic subtest: pipe-A-eDP-1
[97.566981] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[97.576692] Starting dynamic subtest: pipe-B-eDP-1
[97.597099] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[97.604456] Starting dynamic subtest: pipe-C-eDP-1
[97.625152] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[97.631950] Starting dynamic subtest: pipe-D-eDP-1
[97.653613] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[97.658031] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[99.745996] [014/133] (921s left) sriov_basic (bind-unbind-vf)
[99.797031] Starting subtest: bind-unbind-vf
[99.799408] Starting dynamic subtest: vf-1
[99.878509] Dynamic subtest vf-1: FAIL (0.031s)
[99.885964] Starting dynamic subtest: vf-2
[99.959233] Dynamic subtest vf-2: FAIL (0.004s)
[99.968338] Starting dynamic subtest: vf-3
[100.042469] Dynamic subtest vf-3: FAIL (0.004s)
[100.051386] Starting dynamic subtest: vf-4
[100.124334] Dynamic subtest vf-4: FAIL (0.004s)
[100.134039] Starting dynamic subtest: vf-5
[100.206650] Dynamic subtest vf-5: FAIL (0.004s)
[100.215601] Starting dynamic subtest: vf-6
[100.289187] Dynamic subtest vf-6: FAIL (0.004s)
[100.299289] Starting dynamic subtest: vf-7
[100.372862] Dynamic subtest vf-7: FAIL (0.004s)
[100.379624] Starting dynamic subtest: vf-random
[100.450875] Dynamic subtest vf-random: FAIL (0.004s)
[100.459967] Starting dynamic subtest: vf-last
[100.532560] Dynamic subtest vf-last: FAIL (0.508s)
[100.534601] Subtest bind-unbind-vf: FAIL (0.571s)
[100.573801] [015/133] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[100.665339] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[100.669160] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[100.751273] [016/133] (920s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[100.847105] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[100.848943] Starting dynamic subtest: A-eDP1
[104.484706] Dynamic subtest A-eDP1: SUCCESS (3.635s)
[104.496160] Starting dynamic subtest: B-eDP1
[107.683085] Dynamic subtest B-eDP1: SUCCESS (3.196s)
[107.694459] Starting dynamic subtest: C-eDP1
[110.794768] Dynamic subtest C-eDP1: SUCCESS (3.113s)
[110.807589] Starting dynamic subtest: D-eDP1
[113.885148] Dynamic subtest D-eDP1: SUCCESS (3.089s)
[113.887472] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.038s)
[114.687278] [017/133] (906s left) kms_vblank (wait-forked-busy)
[114.780321] Starting subtest: wait-forked-busy
[114.782673] Starting dynamic subtest: pipe-A-eDP-1
[116.668811] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[116.683124] Starting dynamic subtest: pipe-D-eDP-1
[119.260882] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.589s)
[119.263142] Subtest wait-forked-busy: SUCCESS (4.477s)
[120.052653] [018/133] (901s left) syncobj_eventfd (invalid-illegal-handle)
[120.108356] Starting subtest: invalid-illegal-handle
[120.110695] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[120.205874] [019/133] (900s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[120.304403] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[120.308825] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[120.398656] [020/133] (900s left) kms_vrr (flip-suspend)
[120.496070] Starting subtest: flip-suspend
[120.502392] Subtest flip-suspend: SKIP (0.000s)
[120.598980] [021/133] (900s left) kms_setmode (basic)
[120.671576] Starting subtest: basic
[120.993434] Starting dynamic subtest: pipe-A-eDP-1
[123.070641] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.073s)
[123.426889] Starting dynamic subtest: pipe-B-eDP-1
[125.500804] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.082s)
[125.817291] Subtest basic: SUCCESS (5.143s)
[126.647315] [022/133] (894s left) kms_plane_alpha_blend (coverage-7efc)
[126.742214] Starting subtest: coverage-7efc
[127.046368] Starting dynamic subtest: pipe-A-eDP-1
[127.615605] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[127.643905] Starting dynamic subtest: pipe-D-eDP-1
[128.964067] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[128.966212] Subtest coverage-7efc: SUCCESS (2.224s)
[129.801299] [023/133] (891s left) kms_invalid_mode (overflow-vrefresh)
[129.900694] Starting subtest: overflow-vrefresh
[129.903070] Starting dynamic subtest: pipe-A-eDP-1
[130.203074] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.302s)
[130.211664] Starting dynamic subtest: pipe-B-eDP-1
[130.213808] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[130.221177] Starting dynamic subtest: pipe-C-eDP-1
[130.223390] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[130.230724] Starting dynamic subtest: pipe-D-eDP-1
[130.232823] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[130.235061] Subtest overflow-vrefresh: SUCCESS (0.308s)
[131.046442] [024/133] (890s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[131.146880] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[131.157215] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[131.231856] [025/133] (890s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[131.328038] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[131.339810] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[131.422964] [026/133] (890s left) kms_cursor_crc (cursor-offscreen-128x42)
[131.632696] Starting subtest: cursor-offscreen-128x42
[131.676703] Subtest cursor-offscreen-128x42: SKIP (0.041s)
[131.873993] [027/133] (889s left) gem_exec_schedule (timeslicing)
[131.945538] Starting subtest: timeslicing
[131.947596] Starting dynamic subtest: rcs0
[131.956514] Dynamic subtest rcs0: SUCCESS (0.021s)
[131.964781] Starting dynamic subtest: bcs0
[131.977098] Dynamic subtest bcs0: SUCCESS (0.020s)
[131.984283] Starting dynamic subtest: vcs0
[131.996995] Dynamic subtest vcs0: SUCCESS (0.019s)
[132.003967] Starting dynamic subtest: vcs1
[132.017639] Dynamic subtest vcs1: SUCCESS (0.020s)
[132.025067] Starting dynamic subtest: vecs0
[132.043231] Dynamic subtest vecs0: SUCCESS (0.025s)
[132.050408] Starting dynamic subtest: ccs0
[132.069248] Dynamic subtest ccs0: SUCCESS (0.024s)
[132.071124] Subtest timeslicing: SUCCESS (0.135s)
[133.953339] [028/133] (887s left) i915_query (hwconfig_table)
[134.008682] Starting subtest: hwconfig_table
[134.294336] Subtest hwconfig_table: SUCCESS (0.001s)
[134.330279] [029/133] (887s left) kms_lease (lease-revoke)
[134.445638] Starting subtest: lease-revoke
[134.447817] Starting dynamic subtest: pipe-A-eDP-1
[134.476732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[134.484757] Starting dynamic subtest: pipe-B-eDP-1
[134.507431] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.030s)
[134.517253] Starting dynamic subtest: pipe-C-eDP-1
[134.538880] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[134.546815] Starting dynamic subtest: pipe-D-eDP-1
[134.562767] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[134.565119] Subtest lease-revoke: SUCCESS (0.120s)
[134.692296] [030/133] (886s left) gem_exec_schedule (preempt-other-chain)
[134.755329] Starting subtest: preempt-other-chain
[134.757560] Starting dynamic subtest: rcs0
[134.837730] Dynamic subtest rcs0: SUCCESS (0.088s)
[134.851348] Starting dynamic subtest: bcs0
[134.916272] Dynamic subtest bcs0: SUCCESS (0.079s)
[134.927137] Starting dynamic subtest: vcs0
[135.002181] Dynamic subtest vcs0: SUCCESS (0.086s)
[135.010269] Starting dynamic subtest: vcs1
[135.084985] Dynamic subtest vcs1: SUCCESS (0.082s)
[135.092340] Starting dynamic subtest: vecs0
[135.166910] Dynamic subtest vecs0: SUCCESS (0.080s)
[135.180691] Starting dynamic subtest: ccs0
[135.242304] Dynamic subtest ccs0: SUCCESS (0.076s)
[135.244677] Subtest preempt-other-chain: SUCCESS (0.495s)
[135.990331] [031/133] (885s left) dmabuf_sync_file (export-multiwait)
[136.085662] Starting subtest: export-multiwait
[136.087601] Subtest export-multiwait: SUCCESS (0.001s)
[136.138440] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[136.141856] [032/133] (885s left) kms_flip (busy-flip)
[136.235340] Starting subtest: busy-flip
[136.237641] Starting dynamic subtest: A-eDP1
[137.948639] Dynamic subtest A-eDP1: SUCCESS (1.712s)
[137.959618] Starting dynamic subtest: B-eDP1
[139.584667] Dynamic subtest B-eDP1: SUCCESS (1.634s)
[139.592397] Starting dynamic subtest: C-eDP1
[141.233707] Dynamic subtest C-eDP1: SUCCESS (1.647s)
[141.245546] Starting dynamic subtest: D-eDP1
[142.974285] Dynamic subtest D-eDP1: SUCCESS (1.737s)
[142.979854] Subtest busy-flip: SUCCESS (6.745s)
[144.143058] [033/133] (877s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[144.241323] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[144.245354] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[144.352430] [034/133] (877s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[144.457838] Starting subtest: yf-tiled-32bpp-rotate-180
[144.462061] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[144.555922] [035/133] (877s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[144.664719] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[144.669113] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[144.759519] [036/133] (877s left) kms_color (legacy-gamma-reset)
[144.846043] Starting subtest: legacy-gamma-reset
[144.848180] Starting dynamic subtest: pipe-A-eDP-1
[145.233427] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.387s)
[145.241455] Starting dynamic subtest: pipe-B-eDP-1
[145.245975] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[145.253342] Starting dynamic subtest: pipe-C-eDP-1
[145.258456] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.014s)
[145.266093] Starting dynamic subtest: pipe-D-eDP-1
[145.271481] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[145.273693] Subtest legacy-gamma-reset: SUCCESS (0.428s)
[146.080921] [037/133] (875s left) kms_sequence (get-forked)
[146.180028] Starting subtest: get-forked
[146.181904] Starting dynamic subtest: pipe-A-eDP-1
[148.088341] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.907s)
[148.097295] Starting dynamic subtest: pipe-B-eDP-1
[150.629413] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.539s)
[150.637666] Starting dynamic subtest: pipe-C-eDP-1
[153.150400] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.520s)
[153.158451] Starting dynamic subtest: pipe-D-eDP-1
[155.653858] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.502s)
[155.655830] Subtest get-forked: SUCCESS (9.473s)
[156.503524] [038/133] (865s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[156.596645] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[156.598913] Starting dynamic subtest: pipe-A-eDP-1
[156.698366] Dynamic subtest pipe-A-eDP-1: SKIP (0.103s)
[156.707411] Starting dynamic subtest: pipe-B-eDP-1
[157.877021] Dynamic subtest pipe-B-eDP-1: SKIP (1.177s)
[157.881436] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.283s)
[159.053477] [039/133] (862s left) kms_hdr (bpc-switch-dpms)
[159.146669] Starting subtest: bpc-switch-dpms
[160.227503] Starting dynamic subtest: pipe-A-eDP-1
[164.786205] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.561s)
[164.788552] Subtest bpc-switch-dpms: SUCCESS (5.642s)
[164.923991] [040/133] (857s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[165.047212] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[165.051698] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[165.149873] [041/133] (856s left) gem_ctx_param (set-priority-range)
[165.203957] Starting subtest: set-priority-range
[165.216987] Subtest set-priority-range: SUCCESS (0.013s)
[165.321340] [042/133] (856s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[165.383523] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[165.385863] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[165.484423] [043/133] (856s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[165.599315] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[169.259833] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.664s)
[170.441143] [044/133] (851s left) syncobj_wait (invalid-signal-bad-pad)
[170.495567] Starting subtest: invalid-signal-bad-pad
[170.497727] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[170.587759] [045/133] (851s left) gem_exec_balancer (hog)
[170.646917] Starting subtest: hog
[170.651645] Subtest hog: SKIP (0.000s)
[170.959693] [046/133] (851s left) gem_mmap_gtt (basic-read-write-distinct)
[171.015092] Subtest basic-read-write-distinct: SKIP (0.000s)
[171.078083] [047/133] (851s left) kms_chamelium_color (ctm-red-to-blue)
[171.175218] Subtest ctm-red-to-blue: SKIP (0.000s)
[171.222712] [048/133] (851s left) gen9_exec_parse (allowed-all)
[171.279947] Subtest allowed-all: SKIP (0.000s)
[171.353026] [049/133] (850s left) i915_pm_rpm (gem-execbuf-stress)
[173.097193] Starting subtest: gem-execbuf-stress
[173.099666] Starting dynamic subtest: smem0
[186.055608] Dynamic subtest smem0: SUCCESS (12.961s)
[186.066843] Starting dynamic subtest: extra-wait-smem0
[247.934787] Dynamic subtest extra-wait-smem0: SUCCESS (61.873s)
[247.937631] Subtest gem-execbuf-stress: SUCCESS (74.840s)
[248.326470] [050/133] (774s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[248.420659] Starting subtest: psr-rgb565-draw-blt
[255.533458] Subtest psr-rgb565-draw-blt: SUCCESS (7.116s)
[255.649793] [051/133] (766s left) kms_big_fb (linear-16bpp-rotate-180)
[255.759590] Starting subtest: linear-16bpp-rotate-180
[257.193623] Subtest linear-16bpp-rotate-180: SUCCESS (1.435s)
[257.339879] [052/133] (765s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[257.464546] Starting subtest: flip-vs-cursor-atomic-transitions
[265.423520] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.958s)
[266.245417] [053/133] (756s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[266.346097] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[266.348220] Starting dynamic subtest: pipe-A
[266.457128] Dynamic subtest pipe-A: SKIP (0.107s)
[266.465486] Starting dynamic subtest: pipe-B
[267.620092] Dynamic subtest pipe-B: SKIP (1.162s)
[267.630255] Starting dynamic subtest: pipe-C
[268.843246] Dynamic subtest pipe-C: SUCCESS (1.229s)
[268.852286] Starting dynamic subtest: pipe-D
[270.080368] Dynamic subtest pipe-D: SUCCESS (1.236s)
[270.082705] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.738s)
[271.290644] [054/133] (751s left) gem_wait (wait)
[271.360789] Starting subtest: wait
[271.363296] Starting dynamic subtest: all-engines
[272.917727] Dynamic subtest all-engines: SUCCESS (1.555s)
[272.929085] Starting dynamic subtest: rcs0
[273.967224] Dynamic subtest rcs0: SUCCESS (1.047s)
[273.979742] Starting dynamic subtest: bcs0
[275.014620] Dynamic subtest bcs0: SUCCESS (1.045s)
[275.026511] Starting dynamic subtest: vcs0
[276.059541] Dynamic subtest vcs0: SUCCESS (1.043s)
[276.070022] Starting dynamic subtest: vcs1
[277.105379] Dynamic subtest vcs1: SUCCESS (1.043s)
[277.116732] Starting dynamic subtest: vecs0
[278.151706] Dynamic subtest vecs0: SUCCESS (1.044s)
[278.163044] Starting dynamic subtest: ccs0
[279.200835] Dynamic subtest ccs0: SUCCESS (1.047s)
[279.203759] Subtest wait: SUCCESS (7.840s)
[279.402111] [055/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[279.505647] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[279.509741] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[279.610666] [056/133] (743s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[279.731451] Starting subtest: flip-vs-cursor-crc-legacy
[280.388600] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.657s)
[281.218908] [057/133] (741s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[281.323392] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[288.034069] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.712s)
[288.169780] [058/133] (734s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[288.257756] Starting subtest: fbc-rgb565-draw-render
[292.378214] Subtest fbc-rgb565-draw-render: SUCCESS (4.123s)
[293.554093] [059/133] (729s left) kms_content_protection (dp-mst-type-0-hdcp14)
[293.692135] Starting subtest: dp-mst-type-0-hdcp14
[293.696794] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[293.811838] [060/133] (728s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[293.919838] Starting subtest: yf-tiled-8bpp-rotate-90
[293.924108] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[294.017082] [061/133] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[294.125656] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[294.129862] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[294.235225] [062/133] (728s left) kms_flip (flip-vs-suspend-interruptible)
[294.332541] Starting subtest: flip-vs-suspend-interruptible
[294.334845] Starting dynamic subtest: A-eDP1
[327.297366] Dynamic subtest A-eDP1: SUCCESS (4.419s)
[327.307223] Starting dynamic subtest: B-eDP1
[360.296620] Dynamic subtest B-eDP1: SUCCESS (4.523s)
[360.307167] Starting dynamic subtest: C-eDP1
[409.308502] Dynamic subtest C-eDP1: SUCCESS (4.544s)
[409.322769] Starting dynamic subtest: D-eDP1
[458.313165] Dynamic subtest D-eDP1: SUCCESS (4.514s)
[458.320478] Subtest flip-vs-suspend-interruptible: SUCCESS (18.011s)
[459.502271] [063/133] (563s left) gem_ctx_engines (independent)
[459.568935] Starting subtest: independent
[459.571713] Starting dynamic subtest: rcs0
[459.718499] Dynamic subtest rcs0: SUCCESS (0.145s)
[459.731189] Starting dynamic subtest: bcs0
[459.833010] Dynamic subtest bcs0: SUCCESS (0.113s)
[459.842822] Starting dynamic subtest: vcs0
[459.950681] Dynamic subtest vcs0: SUCCESS (0.114s)
[459.960787] Starting dynamic subtest: vcs1
[460.082825] Dynamic subtest vcs1: SUCCESS (0.129s)
[460.093277] Starting dynamic subtest: vecs0
[460.204332] Dynamic subtest vecs0: SUCCESS (0.119s)
[460.213666] Starting dynamic subtest: ccs0
[460.337659] Dynamic subtest ccs0: SUCCESS (0.131s)
[460.347468] Starting dynamic subtest: all-engines
[460.946988] Dynamic subtest all-engines: SUCCESS (0.599s)
[460.949886] Subtest independent: SUCCESS (1.357s)
[461.828288] [064/133] (561s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[461.952203] Starting subtest: short-busy-flip-before-cursor-toggle
[461.957373] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[462.102551] [065/133] (560s left) fbdev (unaligned-read)
[462.149906] Starting subtest: unaligned-read
[462.167226] Subtest unaligned-read: SUCCESS (0.017s)
[462.232384] [066/133] (560s left) kms_cursor_crc (cursor-sliding-32x32)
[462.387541] Starting subtest: cursor-sliding-32x32
[462.434271] Subtest cursor-sliding-32x32: SKIP (0.042s)
[462.706178] [067/133] (560s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[462.799245] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[462.803297] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[462.886840] [068/133] (560s left) gen3_render_tiledx_blits
[463.012401] [069/133] (560s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[463.105759] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[463.109996] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[464.202711] [070/133] (559s left) gem_set_tiling_vs_pwrite
[464.334737] [071/133] (558s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[464.418215] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[464.420710] Starting dynamic subtest: pipe-A-eDP-1
[464.447334] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[464.456506] Starting dynamic subtest: pipe-B-eDP-1
[464.483833] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[464.492491] Starting dynamic subtest: pipe-C-eDP-1
[464.520486] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[464.529040] Starting dynamic subtest: pipe-D-eDP-1
[464.557305] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[464.562467] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[466.690318] [072/133] (556s left) perf_pmu (init-wait)
[466.740827] Starting subtest: init-wait
[466.743373] Starting dynamic subtest: rcs0
[466.746349] Dynamic subtest rcs0: SUCCESS (0.002s)
[466.756372] Starting dynamic subtest: bcs0
[466.758917] Dynamic subtest bcs0: SUCCESS (0.001s)
[466.768098] Starting dynamic subtest: vcs0
[466.770784] Dynamic subtest vcs0: SUCCESS (0.001s)
[466.779899] Starting dynamic subtest: vcs1
[466.782478] Dynamic subtest vcs1: SUCCESS (0.001s)
[466.791355] Starting dynamic subtest: vecs0
[466.794350] Dynamic subtest vecs0: SUCCESS (0.001s)
[466.803369] Starting dynamic subtest: ccs0
[466.806399] Dynamic subtest ccs0: SUCCESS (0.001s)
[466.809340] Subtest init-wait: SUCCESS (0.009s)
[466.871146] [073/133] (556s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[466.976354] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[466.981272] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[467.073142] [074/133] (556s left) kms_rotation_crc (sprite-rotation-90)
[467.171109] Starting subtest: sprite-rotation-90
[467.175977] Subtest sprite-rotation-90: SKIP (0.001s)
[467.259502] [075/133] (556s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[467.352405] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[467.363291] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[467.443395] [076/133] (556s left) gem_softpin (allocator-nopin-reserve)
[467.499531] Starting subtest: allocator-nopin-reserve
[467.574814] Subtest allocator-nopin-reserve: SUCCESS (0.077s)
[467.691851] [077/133] (555s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[467.780198] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[467.784279] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[467.863334] [078/133] (555s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[469.905980] Starting subtest: dpms-mode-unset-non-lpsp
[471.055475] Subtest dpms-mode-unset-non-lpsp: SKIP (1.143s)
[471.468936] [079/133] (552s left) gem_reg_read (timestamp-moving)
[471.529399] Starting subtest: timestamp-moving
[472.530362] Subtest timestamp-moving: SUCCESS (0.998s)
[472.606935] [080/133] (551s left) kms_addfb_basic (bad-pitch-128)
[472.661725] Starting subtest: bad-pitch-128
[472.663910] Subtest bad-pitch-128: SUCCESS (0.000s)
[472.781961] [081/133] (550s left) syncobj_timeline (signal)
[472.834963] Starting subtest: signal
[472.837400] Subtest signal: SUCCESS (0.000s)
[472.933641] [082/133] (550s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[473.039283] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[473.044551] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[473.140959] [083/133] (550s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[473.235393] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[473.238415] Starting dynamic subtest: pipe-A-eDP-1
[473.263716] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[473.274042] Starting dynamic subtest: pipe-B-eDP-1
[473.296673] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[473.305082] Starting dynamic subtest: pipe-C-eDP-1
[473.327375] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[473.335731] Starting dynamic subtest: pipe-D-eDP-1
[473.359170] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[473.363725] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[475.433376] [084/133] (548s left) gem_exec_reloc (basic-write-gtt)
[475.488252] Subtest basic-write-gtt: SKIP (0.000s)
[475.554775] [085/133] (548s left) kms_psr (pr-sprite-plane-onoff)
[475.641313] Starting subtest: pr-sprite-plane-onoff
[475.646278] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[475.723536] [086/133] (548s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[476.119906] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[476.911591] [087/133] (547s left) gem_exec_schedule (implicit-boths)
[476.991717] Starting subtest: implicit-boths
[476.994121] Starting dynamic subtest: rcs0
[477.087837] Dynamic subtest rcs0: SUCCESS (0.109s)
[477.099734] Starting dynamic subtest: vcs0
[477.185871] Dynamic subtest vcs0: SUCCESS (0.098s)
[477.197343] Starting dynamic subtest: vcs1
[477.272835] Dynamic subtest vcs1: SUCCESS (0.085s)
[477.282340] Starting dynamic subtest: vecs0
[477.364829] Dynamic subtest vecs0: SUCCESS (0.090s)
[477.377044] Starting dynamic subtest: ccs0
[477.451130] Dynamic subtest ccs0: SUCCESS (0.085s)
[477.453747] Subtest implicit-boths: SUCCESS (0.473s)
[478.741431] [088/133] (545s left) kms_atomic_interruptible (universal-setplane-primary)
[478.833746] Starting subtest: universal-setplane-primary
[478.836036] Starting dynamic subtest: pipe-A-eDP-1
[486.289179] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.444s)
[486.291715] Subtest universal-setplane-primary: SUCCESS (7.445s)
[487.112302] [089/133] (536s left) kms_psr (psr-sprite-render)
[487.209490] Starting subtest: psr-sprite-render
[487.212094] Starting dynamic subtest: eDP-1
[488.956608] Dynamic subtest eDP-1: SUCCESS (1.744s)
[488.959260] Subtest psr-sprite-render: SUCCESS (1.745s)
[489.803487] [090/133] (534s left) sw_sync (sync_busy)
[489.846985] Starting subtest: sync_busy
[489.849508] Subtest sync_busy: SUCCESS (0.002s)
[489.907857] [091/133] (534s left) gem_exec_fence (syncobj-invalid-flags)
[490.337511] Starting subtest: syncobj-invalid-flags
[490.340514] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[491.789250] [092/133] (532s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[491.855468] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[491.958152] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[492.039819] [093/133] (532s left) api_intel_allocator (reloc-allocator)
[492.098849] Starting subtest: reloc-allocator
[492.101374] Starting dynamic subtest: basic
[492.104181] Dynamic subtest basic: SUCCESS (0.004s)
[492.113964] Starting dynamic subtest: parallel-one
[492.116087] Dynamic subtest parallel-one: SUCCESS (0.008s)
[492.125032] Starting dynamic subtest: print
[492.127494] Dynamic subtest print: SUCCESS (0.000s)
[492.136085] Starting dynamic subtest: reuse
[492.138254] Dynamic subtest reuse: SUCCESS (0.000s)
[492.147281] Starting dynamic subtest: fork-reopen-allocator
[492.149335] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[492.151608] Subtest reloc-allocator: SUCCESS (0.029s)
[492.239787] [094/133] (532s left) gem_lmem_swapping (massive-random)
[492.291812] Subtest massive-random: SKIP (0.000s)
[492.338836] [095/133] (532s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[492.440509] Starting subtest: fbc-psr2-sprite-mmap-gtt
[492.443246] Starting dynamic subtest: eDP-1
[492.448297] Dynamic subtest eDP-1: SKIP (0.000s)
[492.453642] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[492.512714] [096/133] (531s left) gem_mmap_gtt (hang-busy)
[492.574104] Subtest hang-busy: SKIP (0.000s)
[492.631024] [097/133] (531s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[492.754230] Starting subtest: flip-vs-cursor-atomic
[500.319782] Subtest flip-vs-cursor-atomic: SUCCESS (7.566s)
[501.123526] [098/133] (523s left) gem_ctx_persistence (engines-hang)
[501.200115] Starting subtest: engines-hang
[501.202740] Starting dynamic subtest: rcs0
[501.262919] Dynamic subtest rcs0: SUCCESS (0.062s)
[501.274497] Starting dynamic subtest: bcs0
[501.351042] Dynamic subtest bcs0: SUCCESS (0.086s)
[501.363365] Starting dynamic subtest: vcs0
[501.454162] Dynamic subtest vcs0: SUCCESS (0.101s)
[501.466478] Starting dynamic subtest: vcs1
[501.553646] Dynamic subtest vcs1: SUCCESS (0.097s)
[501.566274] Starting dynamic subtest: vecs0
[501.656747] Dynamic subtest vecs0: SUCCESS (0.101s)
[501.669046] Starting dynamic subtest: ccs0
[501.752781] Dynamic subtest ccs0: SUCCESS (0.094s)
[501.755874] Subtest engines-hang: SUCCESS (0.554s)
[501.849155] [099/133] (522s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[501.961644] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[501.966483] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[502.037189] [100/133] (522s left) gem_media_vme
[502.166327] [101/133] (522s left) vgem_basic (busy-fence)
[502.212042] Starting subtest: busy-fence
[502.214374] Subtest busy-fence: SUCCESS (0.000s)
[502.268868] [102/133] (522s left) kms_plane_multiple (2x-tiling-none)
[502.362092] Starting subtest: 2x-tiling-none
[502.366174] Subtest 2x-tiling-none: SKIP (0.000s)
[502.433889] [103/133] (522s left) prime_mmap (test_forked_cpu_write)
[502.485052] Starting subtest: test_forked_cpu_write
[502.487007] Starting dynamic subtest: test_forked_cpu_write-smem
[502.492762] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[502.495150] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[502.590759] [104/133] (522s left) syncobj_wait (multi-wait-submitted-signaled)
[502.643700] Starting subtest: multi-wait-submitted-signaled
[502.646249] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[502.729826] [105/133] (522s left) gem_bad_reloc (negative-reloc-bltcopy)
[502.784313] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[502.855224] [106/133] (521s left) kms_cursor_crc (cursor-random-64x21)
[503.047412] Starting subtest: cursor-random-64x21
[503.094017] Subtest cursor-random-64x21: SKIP (0.040s)
[503.325851] [107/133] (521s left) kms_psr (fbc-pr-sprite-render)
[503.428833] Starting subtest: fbc-pr-sprite-render
[503.433663] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[503.499190] [108/133] (521s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[503.560754] Starting subtest: invalid-signal-one-illegal-handle
[503.563251] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[503.664879] [109/133] (521s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[503.729931] Starting subtest: invalid-bsd1-flag-on-blt
[503.732241] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[503.839955] [110/133] (521s left) kms_pm_rpm (universal-planes-dpms)
[505.861870] Starting subtest: universal-planes-dpms
[505.864741] Starting dynamic subtest: plane-35
[514.565081] Dynamic subtest plane-35: SUCCESS (8.704s)
[514.577487] Starting dynamic subtest: plane-65
[522.872787] Dynamic subtest plane-65: SUCCESS (8.301s)
[522.885072] Starting dynamic subtest: plane-95
[531.171217] Dynamic subtest plane-95: SUCCESS (8.292s)
[531.183453] Starting dynamic subtest: plane-125
[539.471874] Dynamic subtest plane-125: SUCCESS (8.294s)
[539.487482] Starting dynamic subtest: plane-135
[547.799285] Dynamic subtest plane-135: SUCCESS (8.320s)
[547.811455] Starting dynamic subtest: plane-145
[556.119593] Dynamic subtest plane-145: SUCCESS (8.316s)
[556.122433] Subtest universal-planes-dpms: SUCCESS (50.246s)
[556.508805] [111/133] (468s left) kms_flip (dpms-vs-vblank-race)
[556.604780] Starting subtest: dpms-vs-vblank-race
[556.607188] Starting dynamic subtest: A-eDP1
[561.591719] Dynamic subtest A-eDP1: SUCCESS (4.990s)
[561.601301] Starting dynamic subtest: B-eDP1
[565.179038] Dynamic subtest B-eDP1: SUCCESS (3.584s)
[565.189453] Starting dynamic subtest: C-eDP1
[569.816707] Dynamic subtest C-eDP1: SUCCESS (4.637s)
[569.826843] Starting dynamic subtest: D-eDP1
[574.474393] Dynamic subtest D-eDP1: SUCCESS (4.657s)
[574.477142] Subtest dpms-vs-vblank-race: SUCCESS (17.881s)
[575.349896] [112/133] (449s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[575.456451] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[575.461731] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[575.545887] [113/133] (449s left) i915_drm_fdinfo (busy-check-all)
[575.584291] Starting subtest: busy-check-all
[575.587021] Starting dynamic subtest: rcs0
[575.591896] Dynamic subtest rcs0: SKIP (0.005s)
[575.601451] Starting dynamic subtest: bcs0
[575.606177] Dynamic subtest bcs0: SKIP (0.000s)
[575.617313] Starting dynamic subtest: vcs0
[575.621954] Dynamic subtest vcs0: SKIP (0.000s)
[575.630076] Starting dynamic subtest: vcs1
[575.634294] Dynamic subtest vcs1: SKIP (0.000s)
[575.642503] Starting dynamic subtest: vecs0
[575.646699] Dynamic subtest vecs0: SKIP (0.000s)
[575.655383] Starting dynamic subtest: ccs0
[575.659574] Dynamic subtest ccs0: SKIP (0.000s)
[575.663589] Subtest busy-check-all: SKIP (0.011s)
[575.701258] [114/133] (449s left) gem_pread (snoop)
[575.768317] Subtest snoop: SKIP (0.000s)
[575.822733] [115/133] (449s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[575.911323] Starting subtest: addfb25-y-tiled-small-legacy
[575.916115] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[575.999702] [116/133] (449s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[576.125387] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[576.257505] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.134s)
[576.364615] [117/133] (448s left) kms_async_flips (crc-atomic)
[576.456920] Starting subtest: crc-atomic
[576.832295] Starting dynamic subtest: pipe-A-eDP-1
[579.762305] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.931s)
[580.152150] Starting dynamic subtest: pipe-B-eDP-1
[583.087735] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.938s)
[583.451215] Starting dynamic subtest: pipe-C-eDP-1
[586.298170] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.855s)
[586.674462] Starting dynamic subtest: pipe-D-eDP-1
[589.532252] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.877s)
[589.535532] Subtest crc-atomic: SUCCESS (13.077s)
[590.713861] [118/133] (434s left) gem_ctx_persistence (file)
[590.772489] Starting subtest: file
[590.880486] Subtest file: SUCCESS (0.108s)
[590.997119] [119/133] (434s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[591.096671] Starting subtest: crc-primary-suspend-y-tiled-ccs
[591.098907] Starting dynamic subtest: pipe-A-eDP-1
[591.108689] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[591.124378] Starting dynamic subtest: pipe-B-eDP-1
[591.135359] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[591.149297] Starting dynamic subtest: pipe-C-eDP-1
[591.160297] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[591.169702] Starting dynamic subtest: pipe-D-eDP-1
[591.180165] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[591.185209] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.007s)
[593.280783] [120/133] (432s left) gem_render_copy (linear-to-vebox-yf-tiled)
[593.333465] Starting subtest: linear-to-vebox-yf-tiled
[593.338785] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[593.517124] [121/133] (431s left) gem_exec_schedule (u-submit-golden-slice)
[593.593063] Starting subtest: u-submit-golden-slice
[593.595413] Starting dynamic subtest: rcs0
[593.620313] Dynamic subtest rcs0: SUCCESS (0.039s)
[593.632139] Starting dynamic subtest: bcs0
[593.664502] Dynamic subtest bcs0: SUCCESS (0.043s)
[593.676501] Starting dynamic subtest: vcs0
[593.703482] Dynamic subtest vcs0: SUCCESS (0.039s)
[593.713719] Starting dynamic subtest: vcs1
[593.734724] Dynamic subtest vcs1: SUCCESS (0.030s)
[593.747094] Starting dynamic subtest: vecs0
[593.771353] Dynamic subtest vecs0: SUCCESS (0.036s)
[593.782674] Starting dynamic subtest: ccs0
[593.813817] Dynamic subtest ccs0: SUCCESS (0.040s)
[593.816394] Subtest u-submit-golden-slice: SUCCESS (0.233s)
[594.771585] [122/133] (430s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[594.862987] Starting subtest: primary-yf-tiled-reflect-x-270
[594.867866] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[594.938837] [123/133] (430s left) gem_exec_balancer (parallel-ordering)
[595.208172] Starting subtest: parallel-ordering
[596.431592] Subtest parallel-ordering: SUCCESS (1.226s)
[596.558051] [124/133] (429s left) i915_hangman (gt-engine-error)
[596.621894] Starting subtest: gt-engine-error
[596.624096] Starting dynamic subtest: rcs0
[598.620140] Dynamic subtest rcs0: SUCCESS (1.998s)
[598.632460] Starting dynamic subtest: bcs0
[600.666025] Dynamic subtest bcs0: SUCCESS (2.043s)
[600.679999] Starting dynamic subtest: vcs0
[602.649862] Dynamic subtest vcs0: SUCCESS (1.980s)
[602.662488] Starting dynamic subtest: vcs1
[604.634123] Dynamic subtest vcs1: SUCCESS (1.981s)
[604.647733] Starting dynamic subtest: vecs0
[606.617698] Dynamic subtest vecs0: SUCCESS (1.981s)
[606.633004] Starting dynamic subtest: ccs0
[608.601366] Dynamic subtest ccs0: SUCCESS (1.980s)
[608.604653] Subtest gt-engine-error: SUCCESS (11.980s)
[608.741252] [125/133] (416s left) api_intel_bb (render-ccs)
[608.800024] Starting subtest: render-ccs
[609.155606] Subtest render-ccs: SUCCESS (0.357s)
[609.285762] [126/133] (416s left) gem_eio (create-ext)
[609.491183] Starting subtest: create-ext
[609.807467] Subtest create-ext: SUCCESS (0.317s)
[609.942992] [127/133] (415s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[610.037414] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[616.762285] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.728s)
[616.887504] [128/133] (408s left) gem_flink_basic (double-flink)
[616.949268] Starting subtest: double-flink
[616.951723] Subtest double-flink: SUCCESS (0.000s)
[617.047961] [129/133] (408s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[617.139279] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[617.142087] Starting dynamic subtest: pipe-A
[617.201796] Dynamic subtest pipe-A: SUCCESS (0.065s)
[617.211459] Starting dynamic subtest: pipe-B
[618.344530] Dynamic subtest pipe-B: SUCCESS (1.141s)
[618.355529] Starting dynamic subtest: pipe-C
[619.460715] Dynamic subtest pipe-C: SUCCESS (1.114s)
[619.470176] Starting dynamic subtest: pipe-D
[620.603129] Dynamic subtest pipe-D: SUCCESS (1.141s)
[620.605486] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.467s)
[621.748044] [130/133] (404s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[621.852449] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[621.857383] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[621.943648] [131/133] (403s left) gem_exec_reloc (basic-cpu-gtt)
[622.000084] Subtest basic-cpu-gtt: SKIP (0.000s)
[622.067192] [132/133] (403s left) kms_feature_discovery (psr1)
[622.166486] Starting subtest: psr1
[622.169110] Subtest psr1: SUCCESS (0.000s)
[622.239475] [133/133] (403s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[622.326736] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[622.331621] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[622.411439] Closing watchdogs
results: parsing output: 0/ for test: prime_self_import
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_rotation_crc
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: gem_tiled_blits
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: sriov_basic
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_vblank
results: parsing output: 17/ for test: syncobj_eventfd
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_vrr
results: parsing output: 20/ for test: kms_setmode
results: parsing output: 21/ for test: kms_plane_alpha_blend
results: parsing output: 22/ for test: kms_invalid_mode
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: i915_query
results: parsing output: 28/ for test: kms_lease
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: dmabuf_sync_file
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_color
results: parsing output: 36/ for test: kms_sequence
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: kms_hdr
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_ctx_param
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_chamelium_color
results: parsing output: 47/ for test: gen9_exec_parse
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: gem_wait
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_content_protection
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: gem_ctx_engines
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: fbdev
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gen3_render_tiledx_blits
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: gem_softpin
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: gem_reg_read
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_chamelium_hpd
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_atomic_interruptible
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: sw_sync
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: api_intel_allocator
results: parsing output: 93/ for test: gem_lmem_swapping
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: gem_media_vme
results: parsing output: 100/ for test: vgem_basic
results: parsing output: 101/ for test: kms_plane_multiple
results: parsing output: 102/ for test: prime_mmap
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: gem_bad_reloc
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: kms_pm_rpm
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: gem_pread
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: gem_pxp
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: i915_hangman
results: parsing output: 124/ for test: api_intel_bb
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_flink_basic
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: kms_feature_discovery
results: parsing output: 132/ for test: kms_plane
Done.