[64.247735] Initializing watchdogs
[64.247780]   /dev/watchdog0
[64.260768] [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]
[64.265100] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.267190] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.270600] [001/133] (960s left) perf (non-system-wide-paranoid)
[64.413746] Starting subtest: non-system-wide-paranoid
[64.435331] Subtest non-system-wide-paranoid: SUCCESS (0.024s)
[64.481570] [002/133] (960s left) i915_drm_fdinfo (isolation)
[64.516103] Starting subtest: isolation
[64.518593] Starting dynamic subtest: rcs0
[64.550909] Dynamic subtest rcs0: SKIP (0.033s)
[64.560081] Starting dynamic subtest: bcs0
[64.564514] Dynamic subtest bcs0: SKIP (0.000s)
[64.571074] Starting dynamic subtest: vcs0
[64.575233] Dynamic subtest vcs0: SKIP (0.000s)
[64.581766] Starting dynamic subtest: vcs1
[64.586221] Dynamic subtest vcs1: SKIP (0.000s)
[64.592678] Starting dynamic subtest: vecs0
[64.597141] Dynamic subtest vecs0: SKIP (0.000s)
[64.603541] Starting dynamic subtest: ccs0
[64.608573] Dynamic subtest ccs0: SKIP (0.000s)
[64.613206] Subtest isolation: SKIP (0.036s)
[64.648877] [003/133] (960s left) perf (blocking)
[64.753629] Starting subtest: blocking
[64.755844] Starting dynamic subtest: 0-rcs0
[74.779694] Dynamic subtest 0-rcs0: SUCCESS (10.016s)
[74.786528] Starting dynamic subtest: 1-vcs1
[84.803076] Dynamic subtest 1-vcs1: SUCCESS (10.023s)
[84.805949] Subtest blocking: SUCCESS (20.040s)
[84.847826] [004/133] (940s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[84.964907] Starting subtest: short-flip-before-cursor-atomic-transitions
[85.956384] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.989s)
[86.819357] [005/133] (938s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[86.873266] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[86.877939] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[87.049362] [006/133] (937s left) kms_addfb_basic (bo-too-small)
[87.146923] Starting subtest: bo-too-small
[87.148913] Subtest bo-too-small: SUCCESS (0.000s)
[87.240454] [007/133] (937s left) syncobj_timeline (wait-any-snapshot)
[87.296607] Starting subtest: wait-any-snapshot
[87.376573] Subtest wait-any-snapshot: SUCCESS (0.081s)
[87.446136] [008/133] (937s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[87.509666] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[87.617073] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[87.692357] [009/133] (937s left) syncobj_wait (multi-wait-submitted-signaled)
[87.746275] Starting subtest: multi-wait-submitted-signaled
[87.748771] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[87.839254] [010/133] (937s left) gem_eio (kms)
[88.035077] Starting subtest: kms
[102.589060] Subtest kms: SUCCESS (14.555s)
[102.699552] [FACT gem_eio (kms)] new: kernel.kmod_is_loaded.vgem: true
[102.702606] [011/133] (922s left) kms_psr (fbc-pr-sprite-plane-onoff)
[102.790382] Starting subtest: fbc-pr-sprite-plane-onoff
[102.794761] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[102.860175] [012/133] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[102.950415] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[102.954812] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[103.051262] [013/133] (922s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[103.162841] Starting subtest: cursorB-vs-flipA-atomic
[103.167400] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[103.306622] [014/133] (921s left) gem_exec_fence (expired-history)
[103.716595] Starting subtest: expired-history
[110.674104] Subtest expired-history: SUCCESS (6.959s)
[112.248412] [015/133] (913s left) api_intel_allocator (fork-simple-once)
[112.305780] Starting subtest: fork-simple-once
[112.325147] Subtest fork-simple-once: SUCCESS (0.018s)
[112.448592] [016/133] (912s left) gem_exec_store (pages)
[112.512706] Starting subtest: pages
[112.515045] Starting dynamic subtest: rcs0
[112.602520] Dynamic subtest rcs0: SUCCESS (0.092s)
[112.612947] Starting dynamic subtest: bcs0
[112.681639] Dynamic subtest bcs0: SUCCESS (0.079s)
[112.689701] Starting dynamic subtest: vcs0
[112.758286] Dynamic subtest vcs0: SUCCESS (0.076s)
[112.768680] Starting dynamic subtest: vcs1
[112.844767] Dynamic subtest vcs1: SUCCESS (0.087s)
[112.853806] Starting dynamic subtest: vecs0
[112.923361] Dynamic subtest vecs0: SUCCESS (0.078s)
[112.932469] Starting dynamic subtest: ccs0
[112.989162] Dynamic subtest ccs0: SUCCESS (0.066s)
[112.991386] Subtest pages: SUCCESS (0.479s)
[113.166286] [017/133] (912s left) kms_flip (2x-flip-vs-fences-interruptible)
[113.266485] Starting subtest: 2x-flip-vs-fences-interruptible
[113.270763] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[113.371489] [018/133] (912s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[113.466960] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[113.471541] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[113.550353] [019/133] (911s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[113.612041] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[113.685607] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.019s)
[113.722820] [020/133] (911s left) kms_cursor_crc (cursor-random-32x10)
[113.888695] Starting subtest: cursor-random-32x10
[113.931970] Subtest cursor-random-32x10: SKIP (0.040s)
[114.213058] [021/133] (911s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[114.319176] Starting subtest: psr-rgb101010-draw-mmap-cpu
[121.405800] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.090s)
[121.516966] [022/133] (904s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[121.620776] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[121.623689] Starting dynamic subtest: pipe-A-eDP-1
[121.647246] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[121.655075] Starting dynamic subtest: pipe-B-eDP-1
[121.675122] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[121.682105] Starting dynamic subtest: pipe-C-eDP-1
[121.702673] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[121.709761] Starting dynamic subtest: pipe-D-eDP-1
[121.731695] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[121.736093] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[123.918062] [023/133] (901s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[124.042070] Starting subtest: cursor-vs-flip-atomic
[153.401707] Subtest cursor-vs-flip-atomic: SUCCESS (29.359s)
[154.247716] [024/133] (871s left) kms_joiner (basic-max-non-joiner)
[154.356453] Starting subtest: basic-max-non-joiner
[154.361077] Subtest basic-max-non-joiner: SKIP (0.000s)
[154.433442] [025/133] (871s left) kms_pm_dc (dc5-dpms-negative)
[155.538177] Starting subtest: dc5-dpms-negative
[155.542914] Subtest dc5-dpms-negative: SKIP (0.000s)
[155.633546] [026/133] (870s left) gem_exec_params (larger-than-life-batch)
[155.688831] Starting subtest: larger-than-life-batch
[157.917483] Subtest larger-than-life-batch: SUCCESS (2.227s)
[158.979160] [027/133] (866s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[159.079771] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[159.185330] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[159.264760] [028/133] (866s left) kms_atomic (plane-cursor-legacy)
[159.382179] Starting subtest: plane-cursor-legacy
[159.384562] Starting dynamic subtest: pipe-A-eDP-1
[159.791795] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.411s)
[159.794222] Subtest plane-cursor-legacy: SUCCESS (0.412s)
[160.661141] [029/133] (865s left) gem_wait (write-busy)
[160.722778] Starting subtest: write-busy
[160.724783] Starting dynamic subtest: all-engines
[161.334769] Dynamic subtest all-engines: SUCCESS (0.614s)
[161.349035] Starting dynamic subtest: rcs0
[161.890526] Dynamic subtest rcs0: SUCCESS (0.555s)
[161.904952] Starting dynamic subtest: bcs0
[162.439550] Dynamic subtest bcs0: SUCCESS (0.548s)
[162.453823] Starting dynamic subtest: vcs0
[163.924311] Dynamic subtest vcs0: SUCCESS (1.483s)
[163.938909] Starting dynamic subtest: vcs1
[165.908152] Dynamic subtest vcs1: SUCCESS (1.983s)
[165.923024] Starting dynamic subtest: vecs0
[167.892375] Dynamic subtest vecs0: SUCCESS (1.983s)
[167.906078] Starting dynamic subtest: ccs0
[168.441444] Dynamic subtest ccs0: SUCCESS (0.550s)
[168.443896] Subtest write-busy: SUCCESS (7.721s)
[168.637179] [030/133] (857s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[168.738068] Starting subtest: fbc-rgb101010-draw-mmap-wc
[173.361107] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.628s)
[174.456863] [031/133] (851s left) gem_exec_suspend (basic-s3)
[174.522072] Starting subtest: basic-S3
[174.524466] Starting dynamic subtest: smem
[194.180517] Dynamic subtest smem: SUCCESS (6.341s)
[194.183423] Subtest basic-S3: SUCCESS (6.343s)
[194.381160] [032/133] (831s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[194.502959] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[198.268781] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.732s)
[199.441310] [033/133] (826s left) kms_psr (fbc-psr-cursor-plane-onoff)
[199.532337] Starting subtest: fbc-psr-cursor-plane-onoff
[199.534371] Starting dynamic subtest: eDP-1
[199.538691] Dynamic subtest eDP-1: SKIP (0.000s)
[199.543003] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[199.611349] [034/133] (826s left) kms_cursor_legacy (torture-bo)
[199.731204] Starting subtest: torture-bo
[199.733561] Starting dynamic subtest: pipe-A
[206.226978] Dynamic subtest pipe-A: SUCCESS (6.462s)
[206.242401] Starting dynamic subtest: pipe-B
[212.816199] Dynamic subtest pipe-B: SUCCESS (6.573s)
[212.830996] Starting dynamic subtest: pipe-C
[219.317089] Dynamic subtest pipe-C: SUCCESS (6.494s)
[219.330228] Starting dynamic subtest: pipe-D
[225.684749] Dynamic subtest pipe-D: SUCCESS (6.360s)
[225.699935] Starting dynamic subtest: all-pipes
[231.659391] Dynamic subtest all-pipes: SUCCESS (5.970s)
[231.662026] Subtest torture-bo: SUCCESS (31.864s)
[231.834993] [035/133] (794s left) gem_spin_batch (resubmit-new)
[231.902195] Starting subtest: resubmit-new
[231.904781] Starting dynamic subtest: rcs0
[231.912261] Dynamic subtest rcs0: SUCCESS (0.010s)
[231.925039] Starting dynamic subtest: bcs0
[231.927442] Dynamic subtest bcs0: SUCCESS (0.004s)
[231.936306] Starting dynamic subtest: vcs0
[231.938657] Dynamic subtest vcs0: SUCCESS (0.005s)
[231.947161] Starting dynamic subtest: vcs1
[231.949074] Dynamic subtest vcs1: SUCCESS (0.005s)
[231.956870] Starting dynamic subtest: vecs0
[231.958793] Dynamic subtest vecs0: SUCCESS (0.009s)
[231.966717] Starting dynamic subtest: ccs0
[231.968617] Dynamic subtest ccs0: SUCCESS (0.006s)
[231.970509] Subtest resubmit-new: SUCCESS (0.042s)
[233.256687] [036/133] (792s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[233.354855] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[233.357199] Starting dynamic subtest: pipe-A-eDP-1
[239.294803] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.941s)
[239.305728] Starting dynamic subtest: pipe-B-eDP-1
[245.941721] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.645s)
[245.944130] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.588s)
[246.813067] [037/133] (779s left) gem_mmap_offset (close-race)
[246.869495] Starting subtest: close-race
[266.977016] Subtest close-race: SUCCESS (20.098s)
[267.126099] [038/133] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[267.239690] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[267.244081] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[267.338055] [039/133] (758s left) gem_ctx_persistence (engines-hostile)
[267.388796] Starting subtest: engines-hostile
[267.391013] Starting dynamic subtest: rcs0
[267.457703] Dynamic subtest rcs0: SUCCESS (0.068s)
[267.470157] Starting dynamic subtest: bcs0
[267.561877] Dynamic subtest bcs0: SUCCESS (0.104s)
[267.578876] Starting dynamic subtest: vcs0
[267.652083] Dynamic subtest vcs0: SUCCESS (0.088s)
[267.664256] Starting dynamic subtest: vcs1
[267.756074] Dynamic subtest vcs1: SUCCESS (0.103s)
[267.768282] Starting dynamic subtest: vecs0
[267.862078] Dynamic subtest vecs0: SUCCESS (0.103s)
[267.873838] Starting dynamic subtest: ccs0
[267.949437] Dynamic subtest ccs0: SUCCESS (0.086s)
[267.951967] Subtest engines-hostile: SUCCESS (0.561s)
[268.026437] [040/133] (758s left) kms_busy (extended-pageflip-hang-oldfb)
[268.132856] Starting subtest: extended-pageflip-hang-oldfb
[268.134877] Starting dynamic subtest: pipe-A
[268.522647] Dynamic subtest pipe-A: SUCCESS (0.389s)
[268.533186] Starting dynamic subtest: pipe-D
[269.652223] Dynamic subtest pipe-D: SUCCESS (1.126s)
[269.654482] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.518s)
[270.492306] [041/133] (755s left) kms_content_protection (legacy-hdcp14)
[270.631004] Starting subtest: legacy-hdcp14
[270.635464] Subtest legacy-hdcp14: SKIP (0.000s)
[270.774241] [042/133] (755s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[270.869876] Starting subtest: y-tiled-8bpp-rotate-270
[270.873920] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[270.962234] [043/133] (755s left) gem_exec_balancer (hang)
[271.234544] Starting subtest: hang
[273.234338] Subtest hang: SUCCESS (1.999s)
[273.357926] [044/133] (753s left) gem_exec_reloc (basic-write-gtt-noreloc)
[273.413233] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[273.477374] [045/133] (753s left) kms_dsc (dsc-with-output-formats)
[273.590344] Starting subtest: dsc-with-output-formats
[273.612721] Subtest dsc-with-output-formats: SKIP (0.000s)
[273.666297] [046/133] (752s left) gem_mmap (basic-small-bo)
[273.721765] Subtest basic-small-bo: SKIP (0.000s)
[273.786449] [047/133] (752s left) kms_plane (pixel-format-x-tiled-modifier)
[273.866829] Starting subtest: pixel-format-x-tiled-modifier
[273.897563] Starting dynamic subtest: pipe-A-plane-0
[274.527845] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[274.536484] Starting dynamic subtest: pipe-A-plane-3
[274.928781] Dynamic subtest pipe-A-plane-3: SUCCESS (0.398s)
[274.937651] Starting dynamic subtest: pipe-A-plane-5
[274.941426] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[275.993398] Starting dynamic subtest: pipe-B-plane-0
[276.608369] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s)
[276.617313] Starting dynamic subtest: pipe-B-plane-3
[276.997104] Dynamic subtest pipe-B-plane-3: SUCCESS (0.388s)
[277.006583] Starting dynamic subtest: pipe-B-plane-5
[277.010258] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[277.310981] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.440s)
[278.169085] [048/133] (748s left) sysfs_timeslice_duration (idempotent)
[278.232519] Starting subtest: idempotent
[278.234812] Starting dynamic subtest: vecs0
[278.237068] Dynamic subtest vecs0: SUCCESS (0.000s)
[278.245684] Starting dynamic subtest: ccs0
[278.247908] Dynamic subtest ccs0: SUCCESS (0.001s)
[278.256209] Starting dynamic subtest: vcs0
[278.258104] Dynamic subtest vcs0: SUCCESS (0.001s)
[278.266544] Starting dynamic subtest: bcs0
[278.268660] Dynamic subtest bcs0: SUCCESS (0.000s)
[278.276868] Starting dynamic subtest: rcs0
[278.279064] Dynamic subtest rcs0: SUCCESS (0.000s)
[278.287374] Starting dynamic subtest: vcs1
[278.289624] Dynamic subtest vcs1: SUCCESS (0.000s)
[278.291795] Subtest idempotent: SUCCESS (0.009s)
[278.326853] [049/133] (748s left) kms_lease (simple-lease)
[278.410175] Starting subtest: simple-lease
[278.412423] Starting dynamic subtest: pipe-A-eDP-1
[278.919210] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.506s)
[278.932098] Starting dynamic subtest: pipe-B-eDP-1
[280.320860] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s)
[280.330524] Starting dynamic subtest: pipe-C-eDP-1
[281.724673] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.402s)
[281.734224] Starting dynamic subtest: pipe-D-eDP-1
[283.147238] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.420s)
[283.149661] Subtest simple-lease: SUCCESS (4.735s)
[283.960964] [050/133] (742s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[284.037518] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[284.099708] [051/133] (742s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[284.195867] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[291.073080] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.879s)
[291.210858] [052/133] (735s left) kms_flip (wf_vblank-ts-check)
[291.302378] Starting subtest: wf_vblank-ts-check
[291.304707] Starting dynamic subtest: A-eDP1
[300.223612] Dynamic subtest A-eDP1: SUCCESS (8.928s)
[300.236368] Starting dynamic subtest: B-eDP1
[309.146330] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[309.156936] Starting dynamic subtest: C-eDP1
[318.068017] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[318.078426] Starting dynamic subtest: D-eDP1
[327.005882] Dynamic subtest D-eDP1: SUCCESS (8.938s)
[327.008217] Subtest wf_vblank-ts-check: SUCCESS (35.723s)
[328.239617] [053/133] (698s left) perf (invalid-oa-format-id)
[328.345763] Starting subtest: invalid-oa-format-id
[328.354160] Subtest invalid-oa-format-id: SUCCESS (0.007s)
[328.398989] [054/133] (698s left) gen9_exec_parse (bb-large)
[328.468617] Subtest bb-large: SKIP (0.000s)
[328.526063] [055/133] (698s left) gem_pxp (reject-modify-context-protection-off-2)
[328.648542] Starting subtest: reject-modify-context-protection-off-2
[328.651519] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[328.758084] [056/133] (698s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[328.843201] Starting subtest: plane-upscale-20x20-with-modifiers
[328.845418] Starting dynamic subtest: pipe-A
[329.190357] Dynamic subtest pipe-A: SUCCESS (0.349s)
[329.198726] Starting dynamic subtest: pipe-B
[330.622086] Dynamic subtest pipe-B: SUCCESS (1.430s)
[330.631423] Starting dynamic subtest: pipe-C
[332.043727] Dynamic subtest pipe-C: SUCCESS (1.421s)
[332.052556] Starting dynamic subtest: pipe-D
[333.467951] Dynamic subtest pipe-D: SUCCESS (1.422s)
[333.470467] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.628s)
[334.630998] [057/133] (692s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[334.722593] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[334.724974] Starting dynamic subtest: pipe-A
[334.960098] Dynamic subtest pipe-A: SUCCESS (0.240s)
[334.969618] Starting dynamic subtest: pipe-B
[336.236902] Dynamic subtest pipe-B: SUCCESS (1.275s)
[336.246758] Starting dynamic subtest: pipe-C
[337.562088] Dynamic subtest pipe-C: SUCCESS (1.324s)
[337.572134] Starting dynamic subtest: pipe-D
[338.898351] Dynamic subtest pipe-D: SUCCESS (1.335s)
[338.900731] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.179s)
[340.078052] [058/133] (686s left) gem_ctx_persistence (heartbeat-many)
[340.128997] Starting subtest: heartbeat-many
[340.133690] Subtest heartbeat-many: SKIP (0.000s)
[340.229011] [059/133] (686s left) gem_exec_schedule (lateslice)
[340.303116] Starting subtest: lateslice
[340.305086] Starting dynamic subtest: rcs0
[340.313108] Dynamic subtest rcs0: SUCCESS (0.020s)
[340.323025] Starting dynamic subtest: bcs0
[340.332516] Dynamic subtest bcs0: SUCCESS (0.018s)
[340.342426] Starting dynamic subtest: vcs0
[340.351460] Dynamic subtest vcs0: SUCCESS (0.018s)
[340.360970] Starting dynamic subtest: vcs1
[340.369474] Dynamic subtest vcs1: SUCCESS (0.017s)
[340.378740] Starting dynamic subtest: vecs0
[340.388013] Dynamic subtest vecs0: SUCCESS (0.018s)
[340.396710] Starting dynamic subtest: ccs0
[340.407236] Dynamic subtest ccs0: SUCCESS (0.018s)
[340.409470] Subtest lateslice: SUCCESS (0.115s)
[342.291304] [060/133] (684s left) kms_psr (psr-basic)
[342.373152] Starting subtest: psr-basic
[342.375464] Starting dynamic subtest: eDP-1
[343.952038] Dynamic subtest eDP-1: SUCCESS (1.578s)
[343.954275] Subtest psr-basic: SUCCESS (1.579s)
[344.826572] [061/133] (682s left) gem_mmap_gtt (fault-concurrent)
[344.885105] Subtest fault-concurrent: SKIP (0.000s)
[344.949639] [062/133] (682s left) gem_exec_params (secure-non-master)
[345.014599] Starting subtest: secure-non-master
[345.018730] Subtest secure-non-master: SKIP (0.000s)
[345.131204] [063/133] (682s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[345.231919] Starting subtest: yf-tiled-32bpp-rotate-270
[345.236156] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[345.327566] [064/133] (681s left) gem_exec_reloc (basic-gtt-read)
[345.394585] Subtest basic-gtt-read: SKIP (0.000s)
[345.463138] [065/133] (681s left) gem_exec_reloc (basic-write-wc)
[345.532118] Subtest basic-write-wc: SKIP (0.000s)
[345.603865] [066/133] (681s left) perf_pmu (gt-awake)
[345.640209] Starting subtest: gt-awake
[354.182010] Subtest gt-awake: SUCCESS (8.540s)
[354.284297] [067/133] (673s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[354.382678] Starting subtest: primary-y-tiled-reflect-x-180
[354.442966] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[354.543912] [068/133] (672s left) kms_plane_cursor (viewport)
[354.644256] Starting subtest: viewport
[354.648825] Starting dynamic subtest: pipe-A-eDP-1-size-64
[357.118250] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.474s)
[357.179469] Starting dynamic subtest: pipe-A-eDP-1-size-128
[359.787014] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.617s)
[359.850489] Starting dynamic subtest: pipe-A-eDP-1-size-256
[362.309931] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.471s)
[362.674577] Starting dynamic subtest: pipe-B-eDP-1-size-64
[365.850500] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.186s)
[365.910646] Starting dynamic subtest: pipe-B-eDP-1-size-128
[368.508388] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.604s)
[368.567714] Starting dynamic subtest: pipe-B-eDP-1-size-256
[371.009980] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.448s)
[371.363883] Starting dynamic subtest: pipe-C-eDP-1-size-64
[374.198545] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.848s)
[374.235923] Starting dynamic subtest: pipe-C-eDP-1-size-128
[376.286897] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.058s)
[376.325654] Starting dynamic subtest: pipe-C-eDP-1-size-256
[378.388201] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.069s)
[378.722209] Starting dynamic subtest: pipe-D-eDP-1-size-64
[381.622313] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.911s)
[381.658494] Starting dynamic subtest: pipe-D-eDP-1-size-128
[383.799853] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.147s)
[383.838292] Starting dynamic subtest: pipe-D-eDP-1-size-256
[385.977716] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s)
[386.293784] Subtest viewport: SUCCESS (31.645s)
[387.167333] [069/133] (640s left) syncobj_timeline (signal)
[387.230388] Starting subtest: signal
[387.232622] Subtest signal: SUCCESS (0.000s)
[387.339728] [070/133] (640s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[387.399988] Starting subtest: y-tiled-ccs-to-y-tiled
[387.404784] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[387.585430] [071/133] (640s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[387.693809] Starting subtest: x-tiled-64bpp-rotate-270
[387.714007] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[387.827856] [072/133] (639s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[387.931797] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[387.936229] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[388.021918] [073/133] (639s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[388.076954] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[388.079114] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[388.168102] [074/133] (639s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[388.265128] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[388.269743] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[389.423826] [075/133] (638s left) kms_big_fb (linear-addfb)
[389.520637] Starting subtest: linear-addfb
[389.523019] Subtest linear-addfb: SUCCESS (0.000s)
[389.614165] [076/133] (638s left) kms_sequence (queue-idle)
[389.710398] Starting subtest: queue-idle
[389.712492] Starting dynamic subtest: pipe-A-eDP-1
[391.521717] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[391.532096] Starting dynamic subtest: pipe-B-eDP-1
[393.972237] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.444s)
[393.982987] Starting dynamic subtest: pipe-C-eDP-1
[396.402321] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.431s)
[396.413704] Starting dynamic subtest: pipe-D-eDP-1
[398.838413] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.435s)
[398.841051] Subtest queue-idle: SUCCESS (9.127s)
[399.647204] [077/133] (628s left) gem_ccs (block-multicopy-compressed)
[399.715846] Starting subtest: block-multicopy-compressed
[399.720598] Subtest block-multicopy-compressed: SKIP (0.000s)
[399.820339] [078/133] (628s left) kms_chamelium_frames (dp-crc-multiple)
[400.203270] Subtest dp-crc-multiple: SKIP (0.000s)
[401.063779] [079/133] (626s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[401.167512] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[401.169738] Starting dynamic subtest: pipe-A-eDP-1
[401.191779] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[401.202980] Starting dynamic subtest: pipe-B-eDP-1
[401.224101] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[401.233744] Starting dynamic subtest: pipe-C-eDP-1
[401.255262] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[401.265398] Starting dynamic subtest: pipe-D-eDP-1
[401.286102] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[401.290275] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[403.447928] [080/133] (624s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[403.542321] Starting subtest: psr2-cursor-plane-update-sf
[403.544610] Starting dynamic subtest: pipe-A-eDP-1
[404.089889] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[404.100227] Starting dynamic subtest: pipe-B-eDP-1
[405.336764] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.246s)
[405.339002] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.800s)
[406.218073] [081/133] (621s left) kms_flip (bo-too-big)
[406.312736] Starting subtest: bo-too-big
[406.314981] Starting dynamic subtest: A-eDP1
[407.661726] Dynamic subtest A-eDP1: SUCCESS (1.348s)
[407.674102] Starting dynamic subtest: B-eDP1
[408.984124] Dynamic subtest B-eDP1: SUCCESS (1.319s)
[408.994108] Starting dynamic subtest: C-eDP1
[410.311369] Dynamic subtest C-eDP1: SUCCESS (1.326s)
[410.321115] Starting dynamic subtest: D-eDP1
[411.643425] Dynamic subtest D-eDP1: SUCCESS (1.329s)
[411.649409] Subtest bo-too-big: SUCCESS (5.334s)
[412.853301] [082/133] (615s left) dmabuf (all-tests)
[412.903427] Starting subtest: all-tests
[412.905716] Starting dynamic subtest: sanitycheck
[413.033069] Dynamic subtest sanitycheck: SUCCESS (0.129s)
[413.046125] Starting dynamic subtest: dma_fence
[413.242045] Dynamic subtest dma_fence: SUCCESS (0.206s)
[413.254715] Starting dynamic subtest: dma_fence_chain
[421.281384] Dynamic subtest dma_fence_chain: SUCCESS (8.035s)
[421.293313] Starting dynamic subtest: dma_fence_unwrap
[421.383975] Dynamic subtest dma_fence_unwrap: SUCCESS (0.101s)
[421.406467] Starting dynamic subtest: dma_resv
[421.482130] Dynamic subtest dma_resv: SUCCESS (0.096s)
[421.484851] Subtest all-tests: SUCCESS (8.579s)
[421.549594] [083/133] (606s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[421.646553] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[421.651015] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[421.716826] [084/133] (606s left) gem_sync (basic-each)
[421.786711] Starting subtest: basic-each
[424.162056] Subtest basic-each: SUCCESS (2.385s)
[424.342788] [085/133] (603s left) kms_chamelium_color (ctm-green-to-red)
[424.439418] Subtest ctm-green-to-red: SKIP (0.000s)
[424.485379] [086/133] (603s left) gem_lmem_swapping (parallel-random)
[424.534883] Subtest parallel-random: SKIP (0.000s)
[424.587204] [087/133] (603s left) gem_ctx_param (root-set)
[424.644192] Starting subtest: root-set
[424.646559] Subtest root-set: SUCCESS (0.001s)
[424.763423] [088/133] (603s left) gem_pxp (create-regular-buffer)
[424.819371] Starting subtest: create-regular-buffer
[424.821749] Subtest create-regular-buffer: SUCCESS (0.000s)
[424.926175] [089/133] (603s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[425.023591] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[428.607338] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.588s)
[429.759664] [090/133] (598s left) kms_psr (fbc-psr-suspend)
[429.853563] Starting subtest: fbc-psr-suspend
[429.855831] Starting dynamic subtest: eDP-1
[429.860077] Dynamic subtest eDP-1: SKIP (0.000s)
[429.864357] Subtest fbc-psr-suspend: SKIP (0.001s)
[429.926230] [091/133] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[430.019679] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[430.023907] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[430.152762] [092/133] (598s left) intel_hwmon (hwmon-write)
[430.204104] Subtest hwmon-write: SKIP (0.000s)
[430.262914] [093/133] (598s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[430.355959] Starting subtest: bad-aux-stride-yf-tiled-ccs
[430.358093] Starting dynamic subtest: pipe-A-eDP-1
[430.378946] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[430.391566] Starting dynamic subtest: pipe-B-eDP-1
[430.412292] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[430.423402] Starting dynamic subtest: pipe-C-eDP-1
[430.444303] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[430.455884] Starting dynamic subtest: pipe-D-eDP-1
[430.477183] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[430.481245] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[432.538332] [094/133] (596s left) perf (global-sseu-config)
[432.638039] Starting subtest: global-sseu-config
[432.642238] Subtest global-sseu-config: SKIP (0.000s)
[432.680742] [095/133] (595s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[433.061480] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[433.849463] [096/133] (594s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[433.963276] Starting subtest: flip-vs-cursor-crc-legacy
[434.607897] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.643s)
[435.406988] [097/133] (593s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[435.509509] Starting subtest: psr-1p-primscrn-cur-indfb-move
[442.885637] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.380s)
[443.021744] [098/133] (585s left) kms_fbcon_fbt (fbc)
[443.086191] Starting subtest: fbc
[449.387196] Subtest fbc: SUCCESS (6.302s)
[450.470087] [099/133] (578s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[450.602335] Starting subtest: cursorA-vs-flipB-atomic-transitions
[450.606719] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[450.782086] [100/133] (578s left) i915_hangman (gt-engine-hang)
[450.863619] Starting subtest: gt-engine-hang
[450.865750] Starting dynamic subtest: rcs0
[452.196540] Dynamic subtest rcs0: SUCCESS (1.333s)
[452.209320] Starting dynamic subtest: bcs0
[454.176981] Dynamic subtest bcs0: SUCCESS (1.978s)
[454.189495] Starting dynamic subtest: vcs0
[456.161885] Dynamic subtest vcs0: SUCCESS (1.983s)
[456.173832] Starting dynamic subtest: vcs1
[458.145617] Dynamic subtest vcs1: SUCCESS (1.981s)
[458.161010] Starting dynamic subtest: vecs0
[460.129967] Dynamic subtest vecs0: SUCCESS (1.981s)
[460.146728] Starting dynamic subtest: ccs0
[462.178490] Dynamic subtest ccs0: SUCCESS (2.045s)
[462.181656] Subtest gt-engine-hang: SUCCESS (11.317s)
[462.260469] [101/133] (566s left) gem_exec_schedule (submit-golden-slice)
[462.329021] Starting subtest: submit-golden-slice
[462.331278] Starting dynamic subtest: rcs0
[462.384283] Dynamic subtest rcs0: SUCCESS (0.060s)
[462.396356] Starting dynamic subtest: bcs0
[462.439657] Dynamic subtest bcs0: SUCCESS (0.055s)
[462.454694] Starting dynamic subtest: vcs0
[462.496627] Dynamic subtest vcs0: SUCCESS (0.056s)
[462.509104] Starting dynamic subtest: vcs1
[462.547037] Dynamic subtest vcs1: SUCCESS (0.049s)
[462.559896] Starting dynamic subtest: vecs0
[462.593033] Dynamic subtest vecs0: SUCCESS (0.045s)
[462.607494] Starting dynamic subtest: ccs0
[462.648142] Dynamic subtest ccs0: SUCCESS (0.053s)
[462.650567] Subtest submit-golden-slice: SUCCESS (0.325s)
[464.298884] [102/133] (564s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[464.408775] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[464.413131] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[464.496075] [103/133] (564s left) kms_big_fb (4-tiled-addfb)
[464.583803] Starting subtest: 4-tiled-addfb
[464.586015] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[464.666226] [104/133] (564s left) gem_create (create-massive)
[464.717931] Starting subtest: create-massive
[464.719854] Subtest create-massive: SUCCESS (0.000s)
[464.918221] [105/133] (564s left) gem_userptr_blits (usage-restrictions)
[464.982608] Starting subtest: usage-restrictions
[464.984660] Subtest usage-restrictions: SUCCESS (0.000s)
[465.111954] [106/133] (564s left) gem_flink_basic (basic)
[465.162312] Starting subtest: basic
[465.164231] Subtest basic: SUCCESS (0.000s)
[465.260613] [107/133] (563s left) syncobj_wait (invalid-signal-bad-pad)
[465.309577] Starting subtest: invalid-signal-bad-pad
[465.311853] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[465.394529] [108/133] (563s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[465.488371] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[472.842746] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.357s)
[472.994116] [109/133] (556s left) sw_sync (timeline_closed)
[473.029093] Starting subtest: timeline_closed
[473.031012] Subtest timeline_closed: SUCCESS (0.000s)
[473.086323] [110/133] (556s left) gem_mmap_wc (coherency)
[473.152256] Subtest coherency: SKIP (0.000s)
[473.249529] [111/133] (556s left) kms_prop_blob (blob-prop-core)
[473.313215] Starting subtest: blob-prop-core
[473.315281] Subtest blob-prop-core: SUCCESS (0.000s)
[473.425855] [112/133] (556s left) kms_psr (psr-sprite-mmap-gtt)
[473.521236] Starting subtest: psr-sprite-mmap-gtt
[473.523510] Starting dynamic subtest: eDP-1
[475.008013] Dynamic subtest eDP-1: SKIP (1.484s)
[475.012864] Subtest psr-sprite-mmap-gtt: SKIP (1.486s)
[475.179676] [113/133] (554s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[475.287016] Starting subtest: psr-1p-primscrn-spr-indfb-move
[482.815684] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.532s)
[482.944320] [114/133] (546s left) syncobj_timeline (invalid-signal-illegal-point)
[482.997334] Starting subtest: invalid-signal-illegal-point
[482.999600] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[483.128026] [115/133] (546s left) api_intel_bb (offset-control)
[483.175225] Starting subtest: offset-control
[483.180797] Subtest offset-control: SUCCESS (0.007s)
[483.290200] [116/133] (546s left) kms_cursor_edge_walk (128x128-top-edge)
[483.374899] Starting subtest: 128x128-top-edge
[483.377321] Starting dynamic subtest: pipe-A-eDP-1
[486.808163] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.433s)
[486.821775] Starting dynamic subtest: pipe-D-eDP-1
[489.922667] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[489.924983] Subtest 128x128-top-edge: SUCCESS (6.547s)
[490.735390] [117/133] (538s left) i915_suspend (forcewake)
[490.795595] Starting subtest: forcewake
[522.333953] Subtest forcewake: SUCCESS (2.307s)
[523.416472] [118/133] (507s left) kms_vblank (ts-continuation-modeset-rpm)
[523.512705] Starting subtest: ts-continuation-modeset-rpm
[523.514979] Starting dynamic subtest: pipe-A-eDP-1
[526.044721] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.531s)
[526.060306] Starting dynamic subtest: pipe-D-eDP-1
[528.303875] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.244s)
[528.306367] Subtest ts-continuation-modeset-rpm: SUCCESS (4.778s)
[529.119615] [119/133] (501s left) kms_pm_rpm (pm-caching)
[530.647695] Starting subtest: pm-caching
[530.652593] Subtest pm-caching: SKIP (0.000s)
[531.375059] [120/133] (499s left) perf (polling)
[531.471287] Starting subtest: polling
[531.473680] Starting dynamic subtest: 0-rcs0
[541.488189] Dynamic subtest 0-rcs0: SUCCESS (9.954s)
[541.499066] Starting dynamic subtest: 1-vecs0
[551.503371] Dynamic subtest 1-vecs0: SUCCESS (9.993s)
[551.506536] Subtest polling: SUCCESS (19.951s)
[551.551541] [121/133] (479s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[551.644366] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[551.648770] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[551.720439] [122/133] (479s left) gem_exec_fence (syncobj-import)
[552.139959] Starting subtest: syncobj-import
[552.146282] Subtest syncobj-import: SUCCESS (0.005s)
[553.504568] [123/133] (477s left) i915_pm_rpm (reg-read-ioctl)
[555.539262] Starting subtest: reg-read-ioctl
[557.821222] Subtest reg-read-ioctl: SUCCESS (2.283s)
[558.190022] [124/133] (472s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[558.294861] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[558.299032] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[558.382887] [125/133] (472s left) kms_cursor_crc (cursor-onscreen-512x512)
[558.663035] Starting subtest: cursor-onscreen-512x512
[558.667617] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[558.821169] [126/133] (472s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[558.885987] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[558.993796] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[559.082318] [127/133] (472s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[559.176917] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[566.113869] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.939s)
[566.265360] [128/133] (464s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[566.358291] Starting subtest: nonblocking-crc-frame-sequence
[566.360160] Starting dynamic subtest: pipe-A-eDP-1
[567.116365] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.757s)
[567.130523] Starting dynamic subtest: pipe-B-eDP-1
[568.520965] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.405s)
[568.531249] Starting dynamic subtest: pipe-C-eDP-1
[569.906616] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s)
[569.917778] Starting dynamic subtest: pipe-D-eDP-1
[571.227618] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[571.229954] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.870s)
[572.044881] [129/133] (459s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[572.139867] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[572.144258] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[572.223087] [130/133] (459s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[572.314995] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[576.977191] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.665s)
[578.145573] [131/133] (453s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[578.238020] Starting subtest: plane-lut1d-ctm3x4
[578.384556] Starting dynamic subtest: pipe-A-plane-0
[578.713600] Dynamic subtest pipe-A-plane-0: FAIL (0.158s)
[578.723346] Starting dynamic subtest: pipe-A-plane-1
[578.932470] Dynamic subtest pipe-A-plane-1: FAIL (0.182s)
[578.942264] Starting dynamic subtest: pipe-A-plane-2
[579.170368] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[580.028866] Starting dynamic subtest: pipe-B-plane-0
[580.474793] Dynamic subtest pipe-B-plane-0: FAIL (0.174s)
[580.486817] Starting dynamic subtest: pipe-B-plane-1
[580.801932] Dynamic subtest pipe-B-plane-1: FAIL (0.155s)
[580.813726] Starting dynamic subtest: pipe-B-plane-2
[581.128773] Dynamic subtest pipe-B-plane-2: FAIL (0.631s)
[582.157813] Starting dynamic subtest: pipe-C-plane-0
[582.670966] Dynamic subtest pipe-C-plane-0: FAIL (0.151s)
[582.681950] Starting dynamic subtest: pipe-C-plane-1
[583.082138] Dynamic subtest pipe-C-plane-1: FAIL (0.603s)
[583.091223] Starting dynamic subtest: pipe-C-plane-2
[583.449180] Dynamic subtest pipe-C-plane-2: FAIL (0.171s)
[584.306966] Starting dynamic subtest: pipe-D-plane-0
[584.886579] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[584.897744] Starting dynamic subtest: pipe-D-plane-1
[585.349681] Dynamic subtest pipe-D-plane-1: FAIL (0.593s)
[585.360257] Starting dynamic subtest: pipe-D-plane-2
[585.781722] Dynamic subtest pipe-D-plane-2: FAIL (0.537s)
[585.882270] Subtest plane-lut1d-ctm3x4: FAIL (7.643s)
[586.754808] [132/133] (444s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[586.862545] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[586.866918] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[586.976287] [133/133] (444s left) syncobj_wait (invalid-signal-zero-handles)
[587.037480] Starting subtest: invalid-signal-zero-handles
[587.040010] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[587.124573] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: i915_drm_fdinfo
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: gem_exec_fence
results: parsing output: 14/ for test: api_intel_allocator
results: parsing output: 15/ for test: gem_exec_store
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: sriov_basic
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_joiner
results: parsing output: 24/ for test: kms_pm_dc
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_atomic
results: parsing output: 28/ for test: gem_wait
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_suspend
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_spin_batch
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: gem_mmap_offset
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_busy
results: parsing output: 40/ for test: kms_content_protection
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: kms_dsc
results: parsing output: 45/ for test: gem_mmap
results: parsing output: 46/ for test: kms_plane
results: parsing output: 47/ for test: sysfs_timeslice_duration
results: parsing output: 48/ for test: kms_lease
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: gem_pxp
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: kms_plane_scaling
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: kms_rotation_crc
results: parsing output: 67/ for test: kms_plane_cursor
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_sequence
results: parsing output: 76/ for test: gem_ccs
results: parsing output: 77/ for test: kms_chamelium_frames
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: dmabuf
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: gem_sync
results: parsing output: 84/ for test: kms_chamelium_color
results: parsing output: 85/ for test: gem_lmem_swapping
results: parsing output: 86/ for test: gem_ctx_param
results: parsing output: 87/ for test: gem_pxp
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: intel_hwmon
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_fbcon_fbt
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: i915_hangman
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_create
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: gem_flink_basic
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: sw_sync
results: parsing output: 109/ for test: gem_mmap_wc
results: parsing output: 110/ for test: kms_prop_blob
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: api_intel_bb
results: parsing output: 115/ for test: kms_cursor_edge_walk
results: parsing output: 116/ for test: i915_suspend
results: parsing output: 117/ for test: kms_vblank
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: i915_pm_rpm
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_pipe_crc_basic
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_color_pipeline
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: syncobj_wait
Done.