[56.347513] Initializing watchdogs
[56.347570]   /dev/watchdog0
[56.362234] [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]
[56.366406] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.368627] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.372799] [001/155] (960s left) kms_atomic (plane-overlay-legacy)
[56.510059] Starting subtest: plane-overlay-legacy
[56.512454] Starting dynamic subtest: pipe-A-eDP-1
[56.944738] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[56.947065] Subtest plane-overlay-legacy: SUCCESS (0.435s)
[57.837224] [002/155] (959s left) gem_softpin (evict-active-interruptible)
[57.896712] Starting subtest: evict-active-interruptible
[57.907279] Subtest evict-active-interruptible: SUCCESS (0.011s)
[58.032180] [003/155] (958s left) syncobj_basic (bad-flags-fd-to-handle)
[58.080055] Starting subtest: bad-flags-fd-to-handle
[58.082334] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[58.183970] [004/155] (958s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[58.287282] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[58.291319] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[58.380161] [005/155] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[58.484172] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[58.488493] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[58.570318] [006/155] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[58.676097] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[65.371443] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.699s)
[65.514686] [007/155] (951s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[65.618881] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[65.623533] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[65.717324] [008/155] (951s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[65.806400] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[65.810903] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[66.913164] [009/155] (950s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[67.014665] Starting subtest: y-tiled-8bpp-rotate-90
[67.018938] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[67.110188] [010/155] (950s left) drm_buddy (drm_buddy)
[67.145203] Starting subtest: drm_buddy
[67.149812] Subtest drm_buddy: SKIP (0.000s)
[67.195625] [011/155] (950s left) gem_create (create-ext-placement-all)
[67.348749] Starting subtest: create-ext-placement-all
[67.351646] Subtest create-ext-placement-all: SUCCESS (0.000s)
[67.445822] [012/155] (949s left) perf_pmu (busy-check-all)
[67.480818] Starting subtest: busy-check-all
[67.482842] Starting dynamic subtest: rcs0
[68.045184] Dynamic subtest rcs0: SUCCESS (0.566s)
[68.057610] Starting dynamic subtest: bcs0
[68.594548] Dynamic subtest bcs0: SUCCESS (0.548s)
[68.604615] Starting dynamic subtest: vcs0
[70.273354] Dynamic subtest vcs0: SUCCESS (1.676s)
[70.282475] Starting dynamic subtest: vcs1
[72.318470] Dynamic subtest vcs1: SUCCESS (2.044s)
[72.327299] Starting dynamic subtest: vecs0
[74.304622] Dynamic subtest vecs0: SUCCESS (1.983s)
[74.315803] Starting dynamic subtest: ccs0
[74.858387] Dynamic subtest ccs0: SUCCESS (0.554s)
[74.861351] Subtest busy-check-all: SUCCESS (7.380s)
[74.976191] [013/155] (942s left) kms_prop_blob (invalid-set-prop-any)
[75.027871] Starting subtest: invalid-set-prop-any
[75.030295] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[75.116221] [014/155] (942s left) kms_cursor_crc (cursor-random-256x85)
[75.374643] Starting subtest: cursor-random-256x85
[75.426083] Subtest cursor-random-256x85: SKIP (0.048s)
[75.622376] [015/155] (941s left) perf (oa-exponents)
[75.754391] Starting subtest: oa-exponents
[75.756753] Starting dynamic subtest: 0-rcs0
[77.546486] Dynamic subtest 0-rcs0: SUCCESS (1.791s)
[77.555171] Starting dynamic subtest: 1-vcs0
[79.375310] Dynamic subtest 1-vcs0: SUCCESS (1.828s)
[79.377862] Subtest oa-exponents: SUCCESS (3.620s)
[79.420914] [016/155] (938s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-plflip-blt)
[79.524427] Starting subtest: psrhdr-2p-primscrn-indfb-plflip-blt
[79.529114] Subtest psrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[79.621848] [017/155] (937s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[79.725043] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[79.729255] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[79.823619] [018/155] (937s left) gem_exercise_blt (fast-copy-emit)
[79.875605] Starting subtest: fast-copy-emit
[79.877954] Starting dynamic subtest: linear-smem-smem-emit
[79.897670] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s)
[79.907169] Starting dynamic subtest: xmajor-smem-smem-emit
[79.917979] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.020s)
[79.925913] Starting dynamic subtest: tile4-smem-smem-emit
[79.942249] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.024s)
[79.949597] Starting dynamic subtest: tile64-smem-smem-emit
[79.959583] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[79.961920] Subtest fast-copy-emit: SUCCESS (0.084s)
[80.085968] [019/155] (937s left) kms_plane_alpha_blend (coverage-7efc)
[80.173242] Starting subtest: coverage-7efc
[80.457885] Starting dynamic subtest: pipe-A-eDP-1
[81.012745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[81.044142] Starting dynamic subtest: pipe-D-eDP-1
[82.357581] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[82.360076] Subtest coverage-7efc: SUCCESS (2.184s)
[83.174964] [020/155] (934s left) kms_psr (fbc-pr-primary-mmap-cpu)
[83.271205] Starting subtest: fbc-pr-primary-mmap-cpu
[83.275717] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[83.343837] [021/155] (934s left) gem_wait (wait)
[83.405824] Starting subtest: wait
[83.408164] Starting dynamic subtest: all-engines
[85.313051] Dynamic subtest all-engines: SUCCESS (1.905s)
[85.322662] Starting dynamic subtest: rcs0
[86.359393] Dynamic subtest rcs0: SUCCESS (1.046s)
[86.370438] Starting dynamic subtest: bcs0
[87.406965] Dynamic subtest bcs0: SUCCESS (1.046s)
[87.416282] Starting dynamic subtest: vcs0
[88.452510] Dynamic subtest vcs0: SUCCESS (1.045s)
[88.463296] Starting dynamic subtest: vcs1
[89.499770] Dynamic subtest vcs1: SUCCESS (1.046s)
[89.510374] Starting dynamic subtest: vecs0
[90.545316] Dynamic subtest vecs0: SUCCESS (1.045s)
[90.554435] Starting dynamic subtest: ccs0
[91.594543] Dynamic subtest ccs0: SUCCESS (1.048s)
[91.597043] Subtest wait: SUCCESS (8.189s)
[91.793973] [022/155] (925s left) gem_render_copy (linear)
[91.850437] Starting subtest: linear
[91.852858] Starting dynamic subtest: smem
[91.897904] Dynamic subtest smem: SUCCESS (0.047s)
[91.900352] Subtest linear: SUCCESS (0.048s)
[92.117425] [023/155] (925s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[92.506676] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[93.297803] [024/155] (924s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[93.414062] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[93.418371] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[93.478857] [025/155] (924s left) gem_mmap_gtt (cpuset-medium-copy)
[93.538235] Subtest cpuset-medium-copy: SKIP (0.000s)
[93.598989] [026/155] (924s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[93.695822] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[93.698192] Starting dynamic subtest: pipe-A-eDP-1
[93.720994] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[93.731079] Starting dynamic subtest: pipe-B-eDP-1
[93.752938] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[93.760998] Starting dynamic subtest: pipe-C-eDP-1
[93.783294] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[93.791339] Starting dynamic subtest: pipe-D-eDP-1
[93.813693] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[93.817775] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[95.953803] [027/155] (921s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render)
[96.056434] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render
[96.060602] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[96.161799] [028/155] (921s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[96.262156] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[103.655366] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.399s)
[103.802254] [029/155] (914s left) kms_psr (fbc-psr-dpms)
[103.893097] Starting subtest: fbc-psr-dpms
[103.895346] Starting dynamic subtest: eDP-1
[103.899395] Dynamic subtest eDP-1: SKIP (0.000s)
[103.903470] Subtest fbc-psr-dpms: SKIP (0.000s)
[103.979603] [030/155] (914s left) api_intel_allocator (two-level-inception)
[104.024839] Starting subtest: two-level-inception
[109.423451] Subtest two-level-inception: SUCCESS (5.399s)
[109.552313] [031/155] (908s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[109.614073] Starting subtest: multi-wait-for-submit-unsubmitted
[109.727134] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.112s)
[109.832549] [032/155] (908s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[109.887822] Starting subtest: multi-wait-all-for-submit-available-signaled
[109.890470] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[110.009648] [033/155] (908s left) kms_joiner (invalid-modeset-force-big-joiner)
[110.116765] Starting subtest: invalid-modeset-force-big-joiner
[110.122116] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[110.179837] [034/155] (907s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[110.281368] Starting subtest: plane-lut1d-ctm3x4-lut1d
[110.417069] Starting dynamic subtest: pipe-A-plane-0
[110.584809] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[110.595935] Starting dynamic subtest: pipe-A-plane-1
[110.739641] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[110.747981] Starting dynamic subtest: pipe-A-plane-2
[110.906082] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[112.088529] Starting dynamic subtest: pipe-B-plane-0
[112.258695] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[112.267163] Starting dynamic subtest: pipe-B-plane-1
[112.425325] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[112.434117] Starting dynamic subtest: pipe-B-plane-2
[112.558490] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[113.794459] Starting dynamic subtest: pipe-C-plane-0
[113.930637] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[113.938865] Starting dynamic subtest: pipe-C-plane-1
[114.075359] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[114.085995] Starting dynamic subtest: pipe-C-plane-2
[114.230411] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[115.452630] Starting dynamic subtest: pipe-D-plane-0
[115.590528] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[115.599405] Starting dynamic subtest: pipe-D-plane-1
[115.746572] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[115.757255] Starting dynamic subtest: pipe-D-plane-2
[115.879350] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[116.171467] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.888s)
[117.012304] [035/155] (901s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[117.118748] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[117.123283] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[117.209898] [036/155] (901s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[117.319281] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[117.323626] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[117.433214] [037/155] (900s left) gem_ccs (block-multicopy-inplace)
[117.488882] Starting subtest: block-multicopy-inplace
[117.493495] Subtest block-multicopy-inplace: SKIP (0.000s)
[117.580651] [038/155] (900s left) syncobj_wait (reset-multiple-signaled)
[117.629805] Starting subtest: reset-multiple-signaled
[117.632120] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[117.748676] [039/155] (900s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[117.842445] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[124.460945] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.622s)
[124.582100] [040/155] (893s left) gem_render_copy (y-tiled)
[124.633530] Starting subtest: y-tiled
[124.637793] Subtest y-tiled: SKIP (0.000s)
[124.814623] [041/155] (893s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[124.925630] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[125.706068] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.783s)
[125.873666] [042/155] (892s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[125.985418] Starting subtest: fbcpsr-rgb565-draw-pwrite
[132.972614] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.993s)
[133.106254] [043/155] (885s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[133.201871] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[133.206357] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[133.303394] [044/155] (885s left) kms_vblank (wait-busy)
[133.387826] Starting subtest: wait-busy
[133.390286] Starting dynamic subtest: pipe-A-eDP-1
[135.265575] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[135.281136] Starting dynamic subtest: pipe-D-eDP-1
[137.849464] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.582s)
[137.851776] Subtest wait-busy: SUCCESS (4.460s)
[138.661404] [045/155] (879s left) i915_drm_fdinfo (virtual-busy-hang)
[138.699702] Starting subtest: virtual-busy-hang
[138.704335] Subtest virtual-busy-hang: SKIP (0.000s)
[138.756907] [046/155] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[138.867700] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[138.871739] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[138.986702] [047/155] (879s left) i915_hangman (engine-engine-error)
[139.063647] Starting subtest: engine-engine-error
[139.065976] Starting dynamic subtest: rcs0
[140.257790] Dynamic subtest rcs0: SUCCESS (1.193s)
[140.271071] Starting dynamic subtest: bcs0
[142.239980] Dynamic subtest bcs0: SUCCESS (1.979s)
[142.251042] Starting dynamic subtest: vcs0
[144.222464] Dynamic subtest vcs0: SUCCESS (1.981s)
[144.234483] Starting dynamic subtest: vcs1
[146.270401] Dynamic subtest vcs1: SUCCESS (2.045s)
[146.282622] Starting dynamic subtest: vecs0
[148.254872] Dynamic subtest vecs0: SUCCESS (1.982s)
[148.264865] Starting dynamic subtest: ccs0
[150.238693] Dynamic subtest ccs0: SUCCESS (1.982s)
[150.241671] Subtest engine-engine-error: SUCCESS (11.174s)
[150.369273] [048/155] (868s left) gem_softpin (reverse)
[150.440784] Starting subtest: reverse
[150.449711] Subtest reverse: SUCCESS (0.009s)
[150.570687] [049/155] (868s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[150.675902] Starting subtest: multiplane-rotation-cropping-top
[168.122955] Subtest multiplane-rotation-cropping-top: SUCCESS (17.449s)
[168.237051] [050/155] (850s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[168.336384] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[168.339826] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[168.418727] [051/155] (850s left) syncobj_timeline (wait-any-interrupted)
[168.470119] Starting subtest: wait-any-interrupted
[168.580032] Subtest wait-any-interrupted: SUCCESS (0.108s)
[168.666427] [052/155] (850s left) prime_self_import (basic-llseek-size)
[168.705353] Starting subtest: basic-llseek-size
[168.720343] Subtest basic-llseek-size: SUCCESS (0.017s)
[168.825140] [053/155] (850s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[168.922693] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[168.926955] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[169.007357] [054/155] (849s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary)
[169.102458] Starting subtest: fbcpsrhdr-indfb-scaledprimary
[169.106671] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s)
[169.193052] [055/155] (849s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[169.288302] Starting subtest: fbc-psr2-sprite-mmap-gtt
[169.290657] Starting dynamic subtest: eDP-1
[169.294967] Dynamic subtest eDP-1: SKIP (0.000s)
[169.299269] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[169.359904] [056/155] (849s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[169.464866] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[170.090332] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.628s)
[170.250164] [057/155] (848s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[170.354466] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[170.356769] Starting dynamic subtest: pipe-A-eDP-1
[187.116580] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.532s)
[187.126181] Starting dynamic subtest: pipe-B-eDP-1
[204.095166] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.468s)
[204.104506] Starting dynamic subtest: pipe-C-eDP-1
[221.057299] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.439s)
[221.067419] Starting dynamic subtest: pipe-D-eDP-1
[238.055365] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.389s)
[238.057838] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.833s)
[239.210115] [058/155] (779s left) kms_lease (page-flip-implicit-plane)
[239.305245] Starting subtest: page-flip-implicit-plane
[239.307794] Starting dynamic subtest: pipe-A-eDP-1
[239.787094] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.481s)
[239.796730] Starting dynamic subtest: pipe-B-eDP-1
[240.964386] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.176s)
[240.974256] Starting dynamic subtest: pipe-C-eDP-1
[242.089393] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[242.099379] Starting dynamic subtest: pipe-D-eDP-1
[243.223249] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[243.225680] Subtest page-flip-implicit-plane: SUCCESS (3.915s)
[244.066420] [059/155] (775s left) kms_sequence (queue-idle)
[244.166672] Starting subtest: queue-idle
[244.168907] Starting dynamic subtest: pipe-A-eDP-1
[245.962244] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.791s)
[245.975057] Starting dynamic subtest: pipe-B-eDP-1
[248.451119] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.486s)
[248.461108] Starting dynamic subtest: pipe-C-eDP-1
[250.959727] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.506s)
[250.969353] Starting dynamic subtest: pipe-D-eDP-1
[253.399011] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.436s)
[253.401383] Subtest queue-idle: SUCCESS (9.225s)
[254.214155] [060/155] (764s left) vgem_basic (busy-fence)
[254.310411] Starting subtest: busy-fence
[254.312878] Subtest busy-fence: SUCCESS (0.000s)
[254.364120] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[254.367518] [061/155] (764s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[254.482160] Starting subtest: protected-encrypted-src-copy-not-readible
[254.601575] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.121s)
[254.713617] [062/155] (764s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[254.802066] Starting subtest: primary-x-tiled-reflect-x-0
[261.834903] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.031s)
[263.078114] [063/155] (756s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[263.174228] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[263.178328] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[263.272913] [064/155] (756s left) syncobj_wait (single-wait-all-for-submit-submitted)
[263.331947] Starting subtest: single-wait-all-for-submit-submitted
[263.435494] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[263.509286] [065/155] (755s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[263.622352] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[263.626728] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[263.734602] [066/155] (755s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt)
[263.829287] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt
[263.833263] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[263.923080] [067/155] (755s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[263.980548] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[263.982911] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[264.070046] [068/155] (755s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[264.132968] Subtest writes-after-reads-uncached: SKIP (0.000s)
[264.191244] [069/155] (755s left) gem_exec_schedule (semaphore-resolve)
[264.271571] Starting subtest: semaphore-resolve
[264.304189] Subtest semaphore-resolve: SUCCESS (0.044s)
[264.637618] [070/155] (754s left) gen9_exec_parse (allowed-single)
[264.695179] Subtest allowed-single: SKIP (0.000s)
[264.761860] [071/155] (754s left) kms_content_protection (atomic-dpms-hdcp14)
[264.897932] Starting subtest: atomic-dpms-hdcp14
[264.902817] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[265.030758] [072/155] (754s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[265.139654] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[265.144118] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[265.233536] [073/155] (754s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-pwrite)
[265.327353] Starting subtest: psrhdr-rgb565-draw-pwrite
[265.331642] Subtest psrhdr-rgb565-draw-pwrite: SKIP (0.000s)
[265.425937] [074/155] (754s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[265.536618] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[265.540709] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[265.627796] [075/155] (754s left) kms_rmfb (rmfb-ioctl)
[265.726369] Starting subtest: rmfb-ioctl
[265.728386] Starting dynamic subtest: pipe-A-eDP-1
[265.832896] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[265.844175] Starting dynamic subtest: pipe-B-eDP-1
[267.028323] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.192s)
[267.042264] Starting dynamic subtest: pipe-C-eDP-1
[268.172900] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.141s)
[268.183118] Starting dynamic subtest: pipe-D-eDP-1
[269.304227] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[269.306671] Subtest rmfb-ioctl: SUCCESS (3.576s)
[270.552289] [076/155] (749s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[270.658605] Starting subtest: fbc-modesetfrombusy
[274.412535] Subtest fbc-modesetfrombusy: SUCCESS (3.762s)
[275.593429] [077/155] (744s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt)
[275.686904] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt
[275.691321] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[275.791079] [078/155] (744s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-onoff)
[275.895428] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-onoff
[275.900042] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[275.993627] [079/155] (743s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[276.096653] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[276.100978] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[276.167803] [080/155] (743s left) syncobj_wait (invalid-reset-zero-handles)
[276.225264] Starting subtest: invalid-reset-zero-handles
[276.227735] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[276.333152] [081/155] (743s left) gem_exec_schedule (fairslice-all)
[276.406749] Starting subtest: fairslice-all
[278.459225] Subtest fairslice-all: SUCCESS (2.057s)
[280.201136] [082/155] (739s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[280.299054] Starting subtest: bad-pixel-format-y-tiled-ccs
[280.301464] Starting dynamic subtest: pipe-A-eDP-1
[280.324878] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[280.335849] Starting dynamic subtest: pipe-B-eDP-1
[280.357245] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[280.365371] Starting dynamic subtest: pipe-C-eDP-1
[280.386404] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[280.395078] Starting dynamic subtest: pipe-D-eDP-1
[280.417416] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[280.421768] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[282.542526] [083/155] (737s left) syncobj_wait (single-wait-all-submitted)
[282.604395] Starting subtest: single-wait-all-submitted
[282.707941] Subtest single-wait-all-submitted: SUCCESS (0.103s)
[282.784820] [084/155] (737s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[282.882973] Starting subtest: 4-tiled-8bpp-rotate-270
[282.905682] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.022s)
[283.008959] [085/155] (737s left) kms_cdclk (mode-transition)
[283.095466] Starting subtest: mode-transition
[283.097754] Starting dynamic subtest: pipe-A-eDP-1
[283.385337] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[283.394156] Starting dynamic subtest: pipe-B-eDP-1
[283.398790] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[283.407443] Starting dynamic subtest: pipe-C-eDP-1
[283.412341] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[283.420997] Starting dynamic subtest: pipe-D-eDP-1
[283.425597] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s)
[283.430094] Subtest mode-transition: SKIP (0.294s)
[284.265679] [086/155] (735s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[284.369300] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[284.373570] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[284.464557] [087/155] (735s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[284.559682] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[284.564032] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[284.666722] [088/155] (735s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[284.722763] Starting subtest: framebuffer-vs-set-tiling
[284.727063] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[284.859351] [089/155] (735s left) kms_frontbuffer_tracking (fbc-tiling-4)
[284.952408] Starting subtest: fbc-tiling-4
[289.125376] Subtest fbc-tiling-4: SUCCESS (4.177s)
[290.274804] [090/155] (730s left) api_intel_bb (intel-bb-blit-y)
[290.336050] Starting subtest: intel-bb-blit-y
[293.728842] Subtest intel-bb-blit-y: SUCCESS (3.390s)
[293.851063] [091/155] (726s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-msflip-blt)
[293.953459] Starting subtest: fbchdr-2p-primscrn-shrfb-msflip-blt
[293.957779] Subtest fbchdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[294.069619] [092/155] (726s left) gem_partial_pwrite_pread (reads-snoop)
[294.130267] Subtest reads-snoop: SKIP (0.000s)
[294.198771] [093/155] (726s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[294.305245] Starting subtest: fbc-farfromfence-mmap-gtt
[294.309234] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[294.390728] [094/155] (726s left) syncobj_eventfd (invalid-illegal-handle)
[294.441598] Starting subtest: invalid-illegal-handle
[294.443891] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[294.534281] [095/155] (726s left) gem_ctx_persistence (many-contexts)
[294.592892] Starting subtest: many-contexts
[339.794340] Subtest many-contexts: SUCCESS (45.173s)
[339.854498] [096/155] (680s left) gem_exec_balancer (waits)
[339.921654] Starting subtest: waits
[346.446041] Subtest waits: SUCCESS (6.527s)
[346.746885] [097/155] (673s left) kms_feature_discovery (display-3x)
[346.837591] Starting subtest: display-3x
[346.842084] Subtest display-3x: SKIP (0.000s)
[346.912897] [098/155] (673s left) kms_flip (basic-flip-vs-dpms)
[347.013131] Starting subtest: basic-flip-vs-dpms
[347.015451] Starting dynamic subtest: A-eDP1
[349.593953] Dynamic subtest A-eDP1: SUCCESS (2.583s)
[349.607565] Starting dynamic subtest: B-eDP1
[351.831414] Dynamic subtest B-eDP1: SUCCESS (2.236s)
[351.845236] Starting dynamic subtest: C-eDP1
[354.107243] Dynamic subtest C-eDP1: SUCCESS (2.272s)
[354.118659] Starting dynamic subtest: D-eDP1
[356.292866] Dynamic subtest D-eDP1: SUCCESS (2.185s)
[356.298351] Subtest basic-flip-vs-dpms: SUCCESS (9.288s)
[357.099036] [099/155] (663s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[357.162367] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[357.164943] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[357.292913] [100/155] (663s left) syncobj_timeline (reset-during-wait-for-submit)
[357.341781] Starting subtest: reset-during-wait-for-submit
[357.446308] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[357.535426] [101/155] (663s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[357.626926] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[357.629285] Starting dynamic subtest: pipe-A
[357.647332] Dynamic subtest pipe-A: SKIP (0.017s)
[357.657585] Starting dynamic subtest: pipe-B
[357.681131] Dynamic subtest pipe-B: SKIP (0.031s)
[357.690845] Starting dynamic subtest: pipe-C
[357.711789] Dynamic subtest pipe-C: SKIP (0.031s)
[357.721051] Starting dynamic subtest: pipe-D
[357.740636] Dynamic subtest pipe-D: SKIP (0.030s)
[357.745113] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.112s)
[357.837737] [102/155] (663s left) kms_pm_dc (dc5-psr)
[358.942523] Starting subtest: dc5-psr
[361.813299] Subtest dc5-psr: SUCCESS (2.872s)
[362.637625] [103/155] (658s left) gem_exec_schedule (pi-distinct-iova)
[362.822740] Starting subtest: pi-distinct-iova
[362.824545] Starting dynamic subtest: rcs0
[362.908720] Dynamic subtest rcs0: SUCCESS (0.087s)
[362.923511] Starting dynamic subtest: vcs0
[362.970318] Dynamic subtest vcs0: SUCCESS (0.061s)
[362.985663] Starting dynamic subtest: vcs1
[363.029548] Dynamic subtest vcs1: SUCCESS (0.058s)
[363.041298] Starting dynamic subtest: vecs0
[363.101322] Dynamic subtest vecs0: SUCCESS (0.069s)
[363.110711] Starting dynamic subtest: ccs0
[363.166796] Dynamic subtest ccs0: SUCCESS (0.064s)
[363.169231] Subtest pi-distinct-iova: SUCCESS (0.347s)
[364.228785] [104/155] (656s left) gem_fenced_exec_thrash (too-many-fences)
[364.281938] Subtest too-many-fences: SKIP (0.000s)
[364.341647] [105/155] (656s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[364.449182] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[368.551306] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.107s)
[369.748050] [106/155] (651s left) vgem_basic (dmabuf-fence)
[369.791929] Starting subtest: dmabuf-fence
[369.794327] Subtest dmabuf-fence: SUCCESS (0.000s)
[369.845892] [107/155] (651s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[369.903618] Starting subtest: y-tiled-to-vebox-y-tiled
[369.908163] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[370.100259] [108/155] (651s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[370.192876] Starting subtest: fbc-1p-pri-indfb-multidraw
[383.239878] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.052s)
[384.654387] [109/155] (636s left) kms_cursor_crc (cursor-offscreen-256x85)
[384.898019] Starting subtest: cursor-offscreen-256x85
[384.948845] Subtest cursor-offscreen-256x85: SKIP (0.046s)
[385.112930] [110/155] (636s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[385.205606] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[385.210022] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[385.308804] [111/155] (635s left) kms_cursor_crc (cursor-sliding-32x32)
[385.443169] Starting subtest: cursor-sliding-32x32
[385.493228] Subtest cursor-sliding-32x32: SKIP (0.046s)
[385.777900] [112/155] (635s left) kms_prime (basic-crc-vgem)
[385.858618] Starting subtest: basic-crc-vgem
[385.860515] Starting dynamic subtest: second-to-first
[386.892397] Dynamic subtest second-to-first: SUCCESS (1.035s)
[386.894410] Subtest basic-crc-vgem: SUCCESS (1.036s)
[387.011771] [113/155] (634s left) kms_psr (pr-primary-mmap-gtt)
[387.137574] Starting subtest: pr-primary-mmap-gtt
[387.141413] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[387.211942] [114/155] (634s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt)
[387.320385] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt
[387.324016] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[387.431646] [115/155] (634s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[387.522550] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[387.526028] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[387.625998] [116/155] (633s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[387.674162] Starting subtest: invalid-smem-bo-on-discrete
[387.677830] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[387.811349] [117/155] (633s left) gem_workarounds (reset-fd)
[387.883128] Starting subtest: reset-fd
[388.066551] Subtest reset-fd: SUCCESS (0.182s)
[388.189866] [118/155] (633s left) gem_exec_whisper (basic-fds-all)
[388.247904] Starting subtest: basic-fds-all
[401.097637] Subtest basic-fds-all: SUCCESS (12.844s)
[401.284419] [119/155] (620s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt)
[401.390379] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt
[401.394590] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[401.492003] [120/155] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[401.598808] Starting subtest: fbcpsr-2p-rte
[401.602716] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[401.695880] [121/155] (620s left) gem_ctx_sseu (engines)
[401.753553] Subtest engines: SKIP (0.000s)
[401.834279] [122/155] (619s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[401.945160] Starting subtest: hdr-modesetfrombusy
[401.949840] Subtest hdr-modesetfrombusy: SKIP (0.000s)
[402.056726] [123/155] (619s left) kms_frontbuffer_tracking (fbc-suspend)
[402.152545] Starting subtest: fbc-suspend
[440.397823] Subtest fbc-suspend: SUCCESS (7.472s)
[441.593518] [124/155] (580s left) gem_partial_pwrite_pread (write-snoop)
[441.661181] Subtest write-snoop: SKIP (0.000s)
[441.745464] [125/155] (580s left) gem_ctx_persistence (engines-hostile)
[441.801854] Starting subtest: engines-hostile
[441.804108] Starting dynamic subtest: rcs0
[441.939333] Dynamic subtest rcs0: SUCCESS (0.137s)
[441.951133] Starting dynamic subtest: bcs0
[442.009213] Dynamic subtest bcs0: SUCCESS (0.067s)
[442.020281] Starting dynamic subtest: vcs0
[442.116457] Dynamic subtest vcs0: SUCCESS (0.105s)
[442.129804] Starting dynamic subtest: vcs1
[442.203084] Dynamic subtest vcs1: SUCCESS (0.084s)
[442.215535] Starting dynamic subtest: vecs0
[442.298177] Dynamic subtest vecs0: SUCCESS (0.092s)
[442.310925] Starting dynamic subtest: ccs0
[442.378244] Dynamic subtest ccs0: SUCCESS (0.078s)
[442.380806] Subtest engines-hostile: SUCCESS (0.576s)
[442.526323] [126/155] (579s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[442.621931] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[442.625396] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[442.707831] [127/155] (579s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[442.808613] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[442.812248] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[442.908390] [128/155] (579s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-pwrite)
[443.004668] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-pwrite
[443.008111] Subtest hdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[443.114546] [129/155] (578s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen)
[443.214567] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen
[443.217991] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[443.334330] [130/155] (578s left) perf_pmu (event-wait)
[443.371938] Starting subtest: event-wait
[443.374020] Starting dynamic subtest: rcs0
[443.377902] Dynamic subtest rcs0: SKIP (0.000s)
[443.381256] Subtest event-wait: SKIP (0.001s)
[443.467842] [131/155] (578s left) syncobj_wait (multi-wait-all-submitted-signaled)
[443.517368] Starting subtest: multi-wait-all-submitted-signaled
[443.626936] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.108s)
[443.702110] [132/155] (578s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[443.793613] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[443.797639] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[443.890784] [133/155] (578s left) gem_mmap_wc (read-write-distinct)
[443.937078] Subtest read-write-distinct: SKIP (0.000s)
[443.995373] [134/155] (578s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[444.086772] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[444.091060] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[444.187481] [135/155] (578s left) prime_busy (hang-wait)
[444.241593] Starting subtest: hang-wait
[444.244035] Starting dynamic subtest: rcs0
[470.465490] Dynamic subtest rcs0: SUCCESS (26.188s)
[470.475232] Starting dynamic subtest: bcs0
[477.546744] Dynamic subtest bcs0: SUCCESS (7.092s)
[477.556521] Starting dynamic subtest: vcs0
[484.525764] Dynamic subtest vcs0: SUCCESS (6.968s)
[484.542135] Starting dynamic subtest: vcs1
[491.495120] Dynamic subtest vcs1: SUCCESS (6.978s)
[491.506666] Starting dynamic subtest: vecs0
[498.528694] Dynamic subtest vecs0: SUCCESS (7.031s)
[498.540398] Starting dynamic subtest: ccs0
[512.437629] Dynamic subtest ccs0: SUCCESS (13.904s)
[512.440234] Subtest hang-wait: SUCCESS (68.168s)
[512.550907] [136/155] (509s left) kms_psr (psr2-no-drrs)
[512.657380] Starting subtest: psr2-no-drrs
[512.659694] Starting dynamic subtest: eDP-1
[514.275992] Dynamic subtest eDP-1: SUCCESS (1.618s)
[514.278173] Subtest psr2-no-drrs: SUCCESS (1.618s)
[515.164685] [137/155] (507s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[515.272718] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[515.276970] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[515.371902] [138/155] (507s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[515.458142] Starting subtest: plane-upscale-20x20-with-modifiers
[515.460289] Starting dynamic subtest: pipe-A
[515.805341] Dynamic subtest pipe-A: SUCCESS (0.348s)
[515.815588] Starting dynamic subtest: pipe-B
[517.262495] Dynamic subtest pipe-B: SUCCESS (1.456s)
[517.273745] Starting dynamic subtest: pipe-C
[518.698824] Dynamic subtest pipe-C: SUCCESS (1.434s)
[518.708528] Starting dynamic subtest: pipe-D
[520.128952] Dynamic subtest pipe-D: SUCCESS (1.429s)
[520.131332] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.672s)
[521.303105] [139/155] (501s left) gem_exec_suspend (basic)
[521.358748] Starting subtest: basic
[521.361284] Starting dynamic subtest: smem
[522.903051] Dynamic subtest smem: SUCCESS (1.542s)
[522.905949] Subtest basic: SUCCESS (1.544s)
[523.088570] [140/155] (499s left) i915_suspend (fence-restore-tiled2untiled)
[523.140474] Starting subtest: fence-restore-tiled2untiled
[523.144883] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[523.254830] [141/155] (499s left) gem_pread (self)
[523.316098] Subtest self: SKIP (0.000s)
[523.390158] [142/155] (499s left) gem_exec_fence (long-history)
[523.882557] Starting subtest: long-history
[530.673837] Subtest long-history: SUCCESS (6.789s)
[531.282368] [143/155] (491s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[531.376036] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[531.380474] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[531.473531] [144/155] (491s left) gem_mmap_offset (isolation)
[531.541519] Starting subtest: isolation
[531.559498] Subtest isolation: SUCCESS (0.007s)
[531.651901] [145/155] (491s left) gem_exec_balancer (parallel)
[531.904051] Starting subtest: parallel
[532.850330] Subtest parallel: SUCCESS (0.946s)
[533.956292] [146/155] (488s left) kms_flip (flip-vs-fences-interruptible)
[534.046386] Starting subtest: flip-vs-fences-interruptible
[534.051007] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[534.148940] [147/155] (488s left) kms_addfb_basic (clobberred-modifier)
[534.202199] Starting subtest: clobberred-modifier
[534.206827] Subtest clobberred-modifier: SKIP (0.000s)
[534.346294] [148/155] (488s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[534.436202] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[534.440283] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[534.533301] [149/155] (488s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[534.629586] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[534.633599] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[534.729416] [150/155] (488s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[534.825725] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[534.830463] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[534.895519] [151/155] (488s left) kms_debugfs (display-on-read-all)
[534.991989] Starting subtest: display-on-read-all
[535.160354] Subtest display-on-read-all: SUCCESS (0.169s)
[535.288317] [152/155] (487s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[535.672909] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[536.522896] [153/155] (486s left) i915_pm_rps (min-max-config-idle)
[536.592647] Starting subtest: min-max-config-idle
[536.596818] Subtest min-max-config-idle: SKIP (0.001s)
[536.717718] [154/155] (486s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[536.827273] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[536.831457] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[536.930349] [155/155] (486s left) gem_set_tiling_vs_pwrite
[537.063964] Closing watchdogs
results: parsing output: 0/ for test: kms_atomic
results: parsing output: 1/ for test: gem_softpin
results: parsing output: 2/ for test: syncobj_basic
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: drm_buddy
results: parsing output: 10/ for test: gem_create
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_prop_blob
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: gem_exercise_blt
results: parsing output: 18/ for test: kms_plane_alpha_blend
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_wait
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: kms_chamelium_edid
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: api_intel_allocator
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_joiner
results: parsing output: 33/ for test: kms_color_pipeline
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_ccs
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: i915_drm_fdinfo
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: i915_hangman
results: parsing output: 47/ for test: gem_softpin
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: prime_self_import
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_lease
results: parsing output: 58/ for test: kms_sequence
results: parsing output: 59/ for test: vgem_basic
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: gem_partial_pwrite_pread
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: gen9_exec_parse
results: parsing output: 70/ for test: kms_content_protection
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_rmfb
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_cdclk
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_partial_pwrite_pread
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_eventfd
results: parsing output: 94/ for test: gem_ctx_persistence
results: parsing output: 95/ for test: gem_exec_balancer
results: parsing output: 96/ for test: kms_feature_discovery
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: kms_pm_dc
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: gem_fenced_exec_thrash
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: vgem_basic
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_prime
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: gem_workarounds
results: parsing output: 117/ for test: gem_exec_whisper
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_ctx_sseu
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_partial_pwrite_pread
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_mmap_wc
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: prime_busy
results: parsing output: 135/ for test: kms_psr
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_plane_scaling
results: parsing output: 138/ for test: gem_exec_suspend
results: parsing output: 139/ for test: i915_suspend
results: parsing output: 140/ for test: gem_pread
results: parsing output: 141/ for test: gem_exec_fence
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: gem_mmap_offset
results: parsing output: 144/ for test: gem_exec_balancer
results: parsing output: 145/ for test: kms_flip
results: parsing output: 146/ for test: kms_addfb_basic
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_plane
results: parsing output: 150/ for test: kms_debugfs
results: parsing output: 151/ for test: kms_chamelium_hpd
results: parsing output: 152/ for test: i915_pm_rps
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_set_tiling_vs_pwrite
Done.