[56.552026] Initializing watchdogs
[56.552071]   /dev/watchdog0
[56.565252] [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.569499] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.571717] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.575105] [001/131] (960s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[56.997270] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[57.788606] [002/131] (959s left) gem_lmem_swapping (verify-ccs)
[57.833895] Subtest verify-ccs: SKIP (0.000s)
[57.877135] [003/131] (959s left) perf (missing-sample-flags)
[58.014054] Starting subtest: missing-sample-flags
[58.016428] Subtest missing-sample-flags: SUCCESS (0.000s)
[58.054350] [004/131] (959s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[63.078714] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[63.083312] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.002s)
[63.965972] [005/131] (953s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[64.070377] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[64.074802] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[64.184665] [006/131] (953s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[64.270091] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[64.272353] Starting dynamic subtest: pipe-A-eDP-1
[97.057469] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.280s)
[97.065126] Starting dynamic subtest: pipe-B-eDP-1
[129.998065] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.701s)
[130.005654] Starting dynamic subtest: pipe-C-eDP-1
[162.993749] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.746s)
[163.002282] Starting dynamic subtest: pipe-D-eDP-1
[195.960260] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.627s)
[195.962995] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (18.358s)
[197.245677] [007/131] (820s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[197.398984] Starting subtest: cursor-rapid-movement-32x32
[197.442626] Subtest cursor-rapid-movement-32x32: SKIP (0.038s)
[197.750546] [008/131] (819s left) perf (invalid-oa-exponent)
[197.850007] Starting subtest: invalid-oa-exponent
[197.865928] Subtest invalid-oa-exponent: SUCCESS (0.015s)
[197.914124] [009/131] (819s left) gem_spin_batch (engines)
[197.984003] Starting subtest: engines
[197.986923] Starting dynamic subtest: rcs0
[201.219922] Dynamic subtest rcs0: SUCCESS (3.246s)
[201.230011] Starting dynamic subtest: bcs0
[204.453814] Dynamic subtest bcs0: SUCCESS (3.243s)
[204.463153] Starting dynamic subtest: vcs0
[207.687308] Dynamic subtest vcs0: SUCCESS (3.240s)
[207.696476] Starting dynamic subtest: vcs1
[210.921825] Dynamic subtest vcs1: SUCCESS (3.238s)
[210.931979] Starting dynamic subtest: vecs0
[214.155857] Dynamic subtest vecs0: SUCCESS (3.237s)
[214.165760] Starting dynamic subtest: ccs0
[217.391255] Dynamic subtest ccs0: SUCCESS (3.237s)
[217.393703] Subtest engines: SUCCESS (19.450s)
[217.666302] [010/131] (799s left) kms_psr (psr-sprite-plane-move)
[217.778894] Starting subtest: psr-sprite-plane-move
[217.781629] Starting dynamic subtest: eDP-1
[219.505128] Dynamic subtest eDP-1: SUCCESS (1.727s)
[219.507928] Subtest psr-sprite-plane-move: SUCCESS (1.728s)
[220.348260] [011/131] (797s left) gem_exec_fence (syncobj-repeat)
[220.796755] Starting subtest: syncobj-repeat
[220.971036] Subtest syncobj-repeat: SUCCESS (0.173s)
[222.415436] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[222.418800] [012/131] (795s left) gem_mmap_offset (perf)
[222.468701] Starting subtest: perf
[222.470733] Starting dynamic subtest: smem0
[222.826613] Dynamic subtest smem0: SUCCESS (0.358s)
[222.829387] Subtest perf: SUCCESS (0.358s)
[223.030076] [013/131] (794s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[223.128830] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[223.131550] Starting dynamic subtest: pipe-A-default-mode
[225.865380] Dynamic subtest pipe-A-default-mode: SUCCESS (2.737s)
[225.868004] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.738s)
[226.727352] [014/131] (790s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[226.851047] Starting subtest: 2x-long-cursor-vs-flip-legacy
[226.855734] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[227.021350] [015/131] (790s left) kms_joiner (basic-ultra-joiner)
[227.129849] Starting subtest: basic-ultra-joiner
[227.135143] Subtest basic-ultra-joiner: SKIP (0.000s)
[227.246252] [016/131] (790s left) gem_ccs (block-copy-uncompressed)
[227.326152] Starting subtest: block-copy-uncompressed
[227.328984] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[227.348282] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.023s)
[227.359017] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[227.367015] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s)
[227.374941] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[227.384211] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[227.393973] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[227.402856] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[227.405824] Subtest block-copy-uncompressed: SUCCESS (0.079s)
[227.564366] [017/131] (790s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[227.620897] Starting subtest: multi-wait-for-submit-available-submitted
[227.623792] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[227.768048] [018/131] (790s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[227.867769] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[227.871842] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[227.989398] [019/131] (789s left) gem_close (basic)
[228.049502] Starting subtest: basic
[228.051872] Subtest basic: SUCCESS (0.000s)
[228.183160] [020/131] (789s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[228.246465] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[228.251275] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[228.455340] [021/131] (789s left) kms_vblank (query-forked-busy-hang)
[228.559893] Starting subtest: query-forked-busy-hang
[228.562625] Starting dynamic subtest: pipe-A-eDP-1
[255.077255] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.512s)
[255.092487] Starting dynamic subtest: pipe-D-eDP-1
[270.109381] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.035s)
[270.111925] Subtest query-forked-busy-hang: SUCCESS (41.551s)
[270.971503] [022/131] (747s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[271.084251] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[272.062811] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.980s)
[272.218569] [023/131] (745s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[272.321742] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[272.325721] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[272.433389] [024/131] (745s left) syncobj_timeline (wait-any-snapshot)
[272.495711] Starting subtest: wait-any-snapshot
[272.577290] Subtest wait-any-snapshot: SUCCESS (0.083s)
[272.679061] [025/131] (745s left) gem_eio (execbuf)
[272.877693] Starting subtest: execbuf
[273.170391] Subtest execbuf: SUCCESS (0.291s)
[273.369768] [026/131] (744s left) kms_psr (psr2-primary-render)
[273.469390] Starting subtest: psr2-primary-render
[273.471552] Starting dynamic subtest: eDP-1
[275.243765] Dynamic subtest eDP-1: SUCCESS (1.775s)
[275.246842] Subtest psr2-primary-render: SUCCESS (1.776s)
[276.149858] [027/131] (742s left) i915_suspend (fence-restore-tiled2untiled)
[276.206943] Starting subtest: fence-restore-tiled2untiled
[276.212579] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[276.335247] [028/131] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[276.450061] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[276.455622] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[276.567518] [029/131] (741s left) perf (non-system-wide-paranoid)
[276.671602] Starting subtest: non-system-wide-paranoid
[276.694636] Subtest non-system-wide-paranoid: SUCCESS (0.023s)
[276.738396] [030/131] (741s left) kms_cursor_crc (cursor-sliding-128x42)
[276.975799] Starting subtest: cursor-sliding-128x42
[277.022410] Subtest cursor-sliding-128x42: SKIP (0.041s)
[277.274091] [031/131] (741s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[277.370463] Starting subtest: fbc-pr-sprite-mmap-gtt
[277.374509] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[277.463996] [032/131] (740s left) gem_exec_capture (capture-invisible)
[277.535641] Starting subtest: capture-invisible
[277.537628] Starting dynamic subtest: smem0
[277.541497] Dynamic subtest smem0: SKIP (0.000s)
[277.545264] Subtest capture-invisible: SKIP (0.000s)
[277.666158] [033/131] (740s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[277.768386] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[277.773258] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[277.897408] [034/131] (740s left) kms_flip (nonexisting-fb)
[277.995792] Starting subtest: nonexisting-fb
[277.998317] Starting dynamic subtest: A-eDP1
[279.210591] Dynamic subtest A-eDP1: SUCCESS (1.215s)
[279.219031] Starting dynamic subtest: B-eDP1
[280.338553] Dynamic subtest B-eDP1: SUCCESS (1.127s)
[280.348402] Starting dynamic subtest: C-eDP1
[281.478975] Dynamic subtest C-eDP1: SUCCESS (1.140s)
[281.494897] Starting dynamic subtest: D-eDP1
[282.707038] Dynamic subtest D-eDP1: SUCCESS (1.226s)
[282.709741] Subtest nonexisting-fb: SUCCESS (4.716s)
[283.909731] [035/131] (734s left) syncobj_basic (bad-flags-handle-to-fd)
[283.970276] Starting subtest: bad-flags-handle-to-fd
[283.972903] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[284.103108] [036/131] (734s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[284.151857] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[284.254347] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[284.358180] [037/131] (734s left) kms_prime (basic-crc-hybrid)
[284.444016] Subtest basic-crc-hybrid: SKIP (0.000s)
[284.553048] [038/131] (734s left) syncobj_wait (multi-wait-submitted)
[284.611871] Starting subtest: multi-wait-submitted
[284.717734] Subtest multi-wait-submitted: SUCCESS (0.107s)
[284.818593] [039/131] (733s left) gem_exec_reloc (basic-wc-read)
[284.872142] Subtest basic-wc-read: SKIP (0.000s)
[284.954333] [040/131] (733s left) kms_flip (basic-plain-flip)
[285.061804] Starting subtest: basic-plain-flip
[285.064557] Starting dynamic subtest: A-eDP1
[286.810159] Dynamic subtest A-eDP1: SUCCESS (1.751s)
[286.819533] Starting dynamic subtest: B-eDP1
[288.457442] Dynamic subtest B-eDP1: SUCCESS (1.647s)
[288.466992] Starting dynamic subtest: C-eDP1
[290.173827] Dynamic subtest C-eDP1: SUCCESS (1.714s)
[290.182886] Starting dynamic subtest: D-eDP1
[291.789526] Dynamic subtest D-eDP1: SUCCESS (1.616s)
[291.795842] Subtest basic-plain-flip: SUCCESS (6.737s)
[293.073587] [041/131] (725s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[293.180578] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[294.170494] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.991s)
[294.301409] [042/131] (724s left) kms_color (invalid-gamma-lut-sizes)
[294.398265] Starting subtest: invalid-gamma-lut-sizes
[294.400888] Starting dynamic subtest: pipe-A
[294.682786] Dynamic subtest pipe-A: SUCCESS (0.286s)
[294.692898] Starting dynamic subtest: pipe-B
[294.695583] Dynamic subtest pipe-B: SUCCESS (0.001s)
[294.704455] Starting dynamic subtest: pipe-C
[294.707018] Dynamic subtest pipe-C: SUCCESS (0.001s)
[294.715603] Starting dynamic subtest: pipe-D
[294.718228] Dynamic subtest pipe-D: SUCCESS (0.001s)
[294.720777] Subtest invalid-gamma-lut-sizes: SUCCESS (0.290s)
[295.509509] [043/131] (723s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[295.614996] Starting subtest: psr-2p-primscrn-cur-indfb-move
[295.619835] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[295.758567] [044/131] (723s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[295.848055] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[295.850877] Starting dynamic subtest: pipe-A
[296.905612] Dynamic subtest pipe-A: SUCCESS (1.060s)
[296.914547] Starting dynamic subtest: pipe-B
[299.017547] Dynamic subtest pipe-B: SUCCESS (2.110s)
[299.025978] Starting dynamic subtest: pipe-C
[300.199277] Dynamic subtest pipe-C: SUCCESS (1.179s)
[300.208596] Starting dynamic subtest: pipe-D
[301.347905] Dynamic subtest pipe-D: SUCCESS (1.148s)
[301.350607] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.501s)
[302.560520] [045/131] (716s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[302.682422] Starting subtest: cursorA-vs-flipA-legacy
[313.846688] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.162s)
[314.681694] [046/131] (704s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[314.785020] Starting subtest: 2x-flip-vs-rmfb-interruptible
[314.796399] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[314.937661] [047/131] (704s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[315.049375] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[315.053986] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[315.169395] [048/131] (703s left) kms_hdr (invalid-hdr)
[315.266270] Starting subtest: invalid-hdr
[317.350229] Starting dynamic subtest: pipe-A-eDP-1
[320.324793] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.975s)
[320.327253] Subtest invalid-hdr: SUCCESS (5.060s)
[320.485525] [049/131] (698s left) gem_softpin (invalid)
[320.558545] Starting subtest: invalid
[320.567040] Subtest invalid: SUCCESS (0.006s)
[320.731565] [050/131] (698s left) gem_wait (wait)
[320.798887] Starting subtest: wait
[320.801873] Starting dynamic subtest: all-engines
[322.329907] Dynamic subtest all-engines: SUCCESS (1.529s)
[322.341240] Starting dynamic subtest: rcs0
[323.382846] Dynamic subtest rcs0: SUCCESS (1.050s)
[323.393970] Starting dynamic subtest: bcs0
[324.435661] Dynamic subtest bcs0: SUCCESS (1.051s)
[324.446137] Starting dynamic subtest: vcs0
[325.484726] Dynamic subtest vcs0: SUCCESS (1.047s)
[325.497919] Starting dynamic subtest: vcs1
[326.536758] Dynamic subtest vcs1: SUCCESS (1.049s)
[326.547763] Starting dynamic subtest: vecs0
[327.586193] Dynamic subtest vecs0: SUCCESS (1.047s)
[327.598031] Starting dynamic subtest: ccs0
[328.639042] Dynamic subtest ccs0: SUCCESS (1.050s)
[328.642016] Subtest wait: SUCCESS (7.840s)
[328.863581] [051/131] (690s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[328.969788] Starting subtest: primary-y-tiled-reflect-x-270
[328.975026] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[329.065459] [052/131] (690s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[329.166688] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[336.152781] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.987s)
[336.313626] [053/131] (682s left) kms_psr (pr-cursor-mmap-gtt)
[336.412750] Starting subtest: pr-cursor-mmap-gtt
[336.417912] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[336.510321] [054/131] (682s left) syncobj_timeline (invalid-transfer-non-existent-point)
[336.558914] Starting subtest: invalid-transfer-non-existent-point
[336.561983] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[336.697400] [055/131] (682s left) gem_tiled_blits (interruptible)
[336.765497] Subtest interruptible: SKIP (0.000s)
[336.844308] [056/131] (682s left) gem_exec_schedule (preempt-queue-chain)
[336.928919] Subtest preempt-queue-chain: SKIP (0.000s)
[337.234533] [057/131] (682s left) gem_mmap_gtt (basic-small-bo-tiledx)
[337.302899] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[337.373438] [058/131] (682s left) kms_legacy_colorkey (basic)
[337.464843] Starting subtest: basic
[337.467650] Starting dynamic subtest: pipe-A
[337.508331] Dynamic subtest pipe-A: SUCCESS (0.045s)
[337.519682] Starting dynamic subtest: pipe-B
[337.522259] Dynamic subtest pipe-B: SUCCESS (0.000s)
[337.530846] Starting dynamic subtest: pipe-C
[337.533166] Dynamic subtest pipe-C: SUCCESS (0.000s)
[337.541202] Starting dynamic subtest: pipe-D
[337.543446] Dynamic subtest pipe-D: SUCCESS (0.000s)
[337.545785] Subtest basic: SUCCESS (0.050s)
[337.601642] [059/131] (681s left) gem_exec_balancer (bonded-true-hang)
[337.863494] Starting subtest: bonded-true-hang
[337.869915] Subtest bonded-true-hang: SKIP (0.000s)
[338.004491] [060/131] (681s left) prime_vgem (shrink)
[338.099705] Starting subtest: shrink
[338.116808] Subtest shrink: SUCCESS (0.018s)
[338.257095] [061/131] (681s left) perf_pmu (most-busy-idle-check-all)
[338.302942] Starting subtest: most-busy-idle-check-all
[338.305788] Starting dynamic subtest: rcs0
[340.315538] Dynamic subtest rcs0: SUCCESS (2.013s)
[340.327613] Starting dynamic subtest: bcs0
[342.299656] Dynamic subtest bcs0: SUCCESS (1.981s)
[342.311873] Starting dynamic subtest: vcs0
[344.345588] Dynamic subtest vcs0: SUCCESS (2.043s)
[344.357815] Starting dynamic subtest: vcs1
[346.330855] Dynamic subtest vcs1: SUCCESS (1.982s)
[346.344345] Starting dynamic subtest: vecs0
[348.315557] Dynamic subtest vecs0: SUCCESS (1.981s)
[348.328911] Starting dynamic subtest: ccs0
[350.299534] Dynamic subtest ccs0: SUCCESS (1.982s)
[350.302493] Subtest most-busy-idle-check-all: SUCCESS (12.001s)
[350.435774] [062/131] (669s left) gem_exec_reloc (basic-write-wc)
[350.499176] Subtest basic-write-wc: SKIP (0.000s)
[350.575694] [063/131] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[350.679154] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[350.683845] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[350.812239] [064/131] (668s left) gem_ctx_exec (basic-norecovery)
[350.862120] Starting subtest: basic-norecovery
[351.113586] Subtest basic-norecovery: SUCCESS (0.252s)
[351.280055] [065/131] (668s left) gem_ctx_engines (invalid-engines)
[351.344215] Starting subtest: invalid-engines
[351.353581] Subtest invalid-engines: SUCCESS (0.009s)
[351.623988] [066/131] (668s left) gem_partial_pwrite_pread (writes-after-reads)
[351.694895] Subtest writes-after-reads: SKIP (0.000s)
[351.761789] [067/131] (668s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[351.866864] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[351.871855] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[352.002639] [068/131] (667s left) gem_pxp (reject-modify-context-protection-off-2)
[352.135912] Starting subtest: reject-modify-context-protection-off-2
[352.138819] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[352.286188] [069/131] (667s left) sysfs_heartbeat_interval (nopreempt)
[352.333242] Starting subtest: nopreempt
[352.335741] Starting dynamic subtest: vecs0
[362.342166] Dynamic subtest vecs0: SUCCESS (10.007s)
[362.355783] Starting dynamic subtest: ccs0
[366.324474] Dynamic subtest ccs0: SUCCESS (3.981s)
[366.336193] Starting dynamic subtest: vcs0
[376.351571] Dynamic subtest vcs0: SUCCESS (10.028s)
[376.366887] Starting dynamic subtest: bcs0
[380.253830] Dynamic subtest bcs0: SUCCESS (3.901s)
[380.265864] Starting dynamic subtest: rcs0
[384.295562] Dynamic subtest rcs0: SUCCESS (4.041s)
[384.307056] Starting dynamic subtest: vcs1
[394.355761] Dynamic subtest vcs1: SUCCESS (10.058s)
[394.358823] Subtest nopreempt: SUCCESS (42.028s)
[394.455478] [070/131] (625s left) kms_cursor_crc (cursor-offscreen-128x42)
[394.710030] Starting subtest: cursor-offscreen-128x42
[394.755587] Subtest cursor-offscreen-128x42: SKIP (0.040s)
[395.017392] [071/131] (625s left) kms_pm_lpsp (screens-disabled)
[396.126603] Starting subtest: screens-disabled
[396.131675] Subtest screens-disabled: SKIP (0.000s)
[396.218935] [072/131] (623s left) perf_pmu (all-busy-idle-check-all)
[396.266791] Starting subtest: all-busy-idle-check-all
[398.298155] Subtest all-busy-idle-check-all: SUCCESS (2.032s)
[398.434208] [073/131] (621s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[398.501269] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[398.581281] [074/131] (621s left) gem_mmap_offset (bad-object)
[398.645265] Starting subtest: bad-object
[398.648157] Subtest bad-object: SUCCESS (0.001s)
[398.763505] [075/131] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[398.874811] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[398.879601] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[398.998483] [076/131] (621s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[399.097905] Starting subtest: fbc-psr-cursor-mmap-cpu
[399.100207] Starting dynamic subtest: eDP-1
[399.104851] Dynamic subtest eDP-1: SKIP (0.000s)
[399.109797] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[399.197258] [077/131] (621s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[399.300738] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[399.968729] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[400.200769] [078/131] (620s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[400.307827] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[400.312854] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[400.439050] [079/131] (619s left) perf_pmu (busy-idle-check-all)
[400.479598] Starting subtest: busy-idle-check-all
[400.481743] Starting dynamic subtest: rcs0
[401.147118] Dynamic subtest rcs0: SUCCESS (0.670s)
[401.159907] Starting dynamic subtest: bcs0
[401.800804] Dynamic subtest bcs0: SUCCESS (0.651s)
[401.813696] Starting dynamic subtest: vcs0
[403.354172] Dynamic subtest vcs0: SUCCESS (1.550s)
[403.365733] Starting dynamic subtest: vcs1
[405.337990] Dynamic subtest vcs1: SUCCESS (1.981s)
[405.349868] Starting dynamic subtest: vecs0
[407.322226] Dynamic subtest vecs0: SUCCESS (1.981s)
[407.336911] Starting dynamic subtest: ccs0
[407.982939] Dynamic subtest ccs0: SUCCESS (0.658s)
[407.986017] Subtest busy-idle-check-all: SUCCESS (7.509s)
[408.117569] [080/131] (612s left) gem_workarounds (reset-context)
[408.190941] Starting subtest: reset-context
[408.356031] Subtest reset-context: SUCCESS (0.165s)
[408.521908] [081/131] (611s left) kms_atomic_transition (modeset-transition-fencing)
[408.636600] Starting subtest: modeset-transition-fencing
[408.638599] Starting dynamic subtest: 1x-outputs
[419.429984] Dynamic subtest 1x-outputs: SUCCESS (10.796s)
[419.432902] Subtest modeset-transition-fencing: SUCCESS (10.798s)
[420.322333] [082/131] (600s left) kms_chamelium_hpd (common-hpd-after-suspend)
[420.708850] Subtest common-hpd-after-suspend: SKIP (0.000s)
[421.504496] [083/131] (599s left) gem_exec_params (rsvd2-dirt)
[421.566799] Starting subtest: rsvd2-dirt
[421.572040] Subtest rsvd2-dirt: SKIP (0.000s)
[421.700222] [084/131] (598s left) kms_properties (crtc-properties-atomic)
[421.788752] Starting subtest: crtc-properties-atomic
[421.791299] Starting dynamic subtest: pipe-A-eDP-1
[422.226000] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[422.237738] Starting dynamic subtest: pipe-B-eDP-1
[423.388805] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.162s)
[423.399367] Starting dynamic subtest: pipe-C-eDP-1
[424.499987] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[424.510139] Starting dynamic subtest: pipe-D-eDP-1
[425.645795] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[425.648545] Subtest crtc-properties-atomic: SUCCESS (3.856s)
[426.488316] [085/131] (594s left) gem_userptr_blits (create-destroy-unsync)
[426.568805] Subtest create-destroy-unsync: SKIP (0.000s)
[426.744309] [086/131] (593s left) gem_exec_whisper (basic-contexts-priority)
[426.814233] Starting subtest: basic-contexts-priority
[451.410328] Subtest basic-contexts-priority: SUCCESS (24.585s)
[451.618529] [087/131] (569s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[451.728881] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[452.785922] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.056s)
[452.952318] [088/131] (567s left) kms_addfb_basic (basic-x-tiled-legacy)
[453.019459] Starting subtest: basic-x-tiled-legacy
[453.023689] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[453.176334] [089/131] (567s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[453.269734] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[453.271775] Starting dynamic subtest: pipe-A-eDP-1
[453.291678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[453.302088] Starting dynamic subtest: pipe-B-eDP-1
[453.320865] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[453.329542] Starting dynamic subtest: pipe-C-eDP-1
[453.349566] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[453.358325] Starting dynamic subtest: pipe-D-eDP-1
[453.378260] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[453.379933] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[455.428071] [090/131] (565s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[455.518836] Starting subtest: plane-use-after-nonblocking-unbind
[455.521580] Starting dynamic subtest: pipe-A-eDP-1
[455.580967] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[455.883991] Starting dynamic subtest: pipe-B-eDP-1
[456.705544] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.830s)
[457.000892] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.483s)
[457.891047] [091/131] (563s left) gem_ctx_persistence (idempotent)
[457.959605] Starting subtest: idempotent
[457.962669] Subtest idempotent: SUCCESS (0.000s)
[458.094853] [092/131] (562s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[458.195025] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[464.884822] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.692s)
[465.048584] [093/131] (555s left) kms_vblank (wait-forked-busy)
[465.156548] Starting subtest: wait-forked-busy
[465.158790] Starting dynamic subtest: pipe-A-eDP-1
[467.035862] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s)
[467.051521] Starting dynamic subtest: pipe-D-eDP-1
[469.653879] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.612s)
[469.656865] Subtest wait-forked-busy: SUCCESS (4.495s)
[470.474830] [094/131] (550s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[475.540683] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[475.543512] Starting dynamic subtest: pipe-A-eDP-1
[476.330811] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s)
[476.340897] Starting dynamic subtest: pipe-B-eDP-1
[477.458795] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[477.464015] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.916s)
[478.669808] [095/131] (542s left) kms_flip (dpms-vs-vblank-race)
[478.780522] Starting subtest: dpms-vs-vblank-race
[478.782868] Starting dynamic subtest: A-eDP1
[483.746704] Dynamic subtest A-eDP1: SUCCESS (4.967s)
[483.762533] Starting dynamic subtest: B-eDP1
[488.375806] Dynamic subtest B-eDP1: SUCCESS (4.629s)
[488.385621] Starting dynamic subtest: C-eDP1
[492.998807] Dynamic subtest C-eDP1: SUCCESS (4.623s)
[493.014813] Starting dynamic subtest: D-eDP1
[497.635011] Dynamic subtest D-eDP1: SUCCESS (4.633s)
[497.638016] Subtest dpms-vs-vblank-race: SUCCESS (18.859s)
[498.522761] [096/131] (522s left) gem_exec_parallel (userptr)
[498.585157] Starting subtest: userptr
[498.587832] Starting dynamic subtest: rcs0
[500.363004] Dynamic subtest rcs0: SUCCESS (1.777s)
[500.375005] Starting dynamic subtest: bcs0
[502.092863] Dynamic subtest bcs0: SUCCESS (1.729s)
[502.103596] Starting dynamic subtest: vcs0
[505.305907] Dynamic subtest vcs0: SUCCESS (3.211s)
[505.318001] Starting dynamic subtest: vcs1
[507.313037] Dynamic subtest vcs1: SUCCESS (2.005s)
[507.325565] Starting dynamic subtest: vecs0
[509.291235] Dynamic subtest vecs0: SUCCESS (1.975s)
[509.303201] Starting dynamic subtest: ccs0
[511.267722] Dynamic subtest ccs0: SUCCESS (1.975s)
[511.270674] Subtest userptr: SUCCESS (12.684s)
[511.477316] [097/131] (509s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[511.581543] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[516.062794] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.486s)
[517.223789] [098/131] (503s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[517.330378] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[517.335690] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[517.455041] [099/131] (503s left) gem_exec_reloc (basic-cpu-wc-active)
[517.516208] Subtest basic-cpu-wc-active: SKIP (0.000s)
[517.594160] [100/131] (503s left) kms_psr (fbc-pr-primary-render)
[517.687663] Starting subtest: fbc-pr-primary-render
[517.692618] Subtest fbc-pr-primary-render: SKIP (0.000s)
[517.786037] [101/131] (503s left) kms_plane_multiple (2x-tiling-x)
[517.880761] Starting subtest: 2x-tiling-x
[517.885810] Subtest 2x-tiling-x: SKIP (0.000s)
[517.981004] [102/131] (503s left) i915_pm_rps (reset)
[518.062261] Starting subtest: reset
[526.514542] Subtest reset: SUCCESS (8.453s)
[526.676789] [103/131] (494s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[526.774788] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[526.777625] Starting dynamic subtest: pipe-A-eDP-1
[526.801716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[526.817890] Starting dynamic subtest: pipe-B-eDP-1
[526.841939] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[526.851037] Starting dynamic subtest: pipe-C-eDP-1
[526.874674] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[526.883822] Starting dynamic subtest: pipe-D-eDP-1
[526.908208] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[526.910999] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[528.988893] [104/131] (492s left) kms_hdr (bpc-switch)
[529.091387] Starting subtest: bpc-switch
[529.107837] Starting dynamic subtest: pipe-A-eDP-1
[532.500034] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.394s)
[532.503046] Subtest bpc-switch: SUCCESS (3.410s)
[532.673668] [105/131] (488s left) kms_getfb (getfb-handle-zero)
[532.767813] Starting subtest: getfb-handle-zero
[532.770078] Subtest getfb-handle-zero: SUCCESS (0.000s)
[532.901321] [106/131] (488s left) api_intel_bb (full-batch)
[532.960786] Starting subtest: full-batch
[532.966486] Subtest full-batch: SUCCESS (0.006s)
[533.135231] [107/131] (488s left) prime_vgem (basic-fence-read)
[533.230731] Starting subtest: basic-fence-read
[533.267557] Subtest basic-fence-read: SKIP (0.034s)
[533.413106] [108/131] (488s left) api_intel_allocator (reopen-fork)
[533.469724] Starting subtest: reopen-fork
[537.098732] Subtest reopen-fork: SUCCESS (3.630s)
[537.201204] [109/131] (484s left) kms_chamelium_color (gamma)
[537.301661] Subtest gamma: SKIP (0.000s)
[537.350171] [110/131] (484s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[537.448882] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[537.451636] Starting dynamic subtest: pipe-A-eDP-1
[537.519840] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[537.530705] Starting dynamic subtest: pipe-B-eDP-1
[537.599815] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[537.611136] Starting dynamic subtest: pipe-C-eDP-1
[537.682810] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[537.692965] Starting dynamic subtest: pipe-D-eDP-1
[537.759476] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[537.764550] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[539.634688] [111/131] (482s left) drm_buddy (drm_buddy)
[539.679728] Starting subtest: drm_buddy
[539.714315] Starting dynamic subtest: drm_test_buddy_alloc_limit
[539.841541] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.129s)
[539.851714] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[539.988493] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.145s)
[539.998459] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[540.146343] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.157s)
[540.156867] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[540.279068] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.130s)
[540.290776] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[540.422547] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.144s)
[540.432891] Starting dynamic subtest: drm_test_buddy_alloc_clear
[540.592869] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.169s)
[540.602304] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[540.688990] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.094s)
[540.698362] Starting dynamic subtest: drm_test_buddy_fragmentation_performance
[544.861828] Dynamic subtest drm_test_buddy_fragmentation_performance: SUCCESS (4.170s)
[544.864884] Subtest drm_buddy: SUCCESS (5.182s)
[545.106355] [112/131] (476s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[545.231680] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[545.236879] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[545.364865] [113/131] (476s left) kms_dsc (dsc-basic)
[545.473800] Starting subtest: dsc-basic
[545.489267] Subtest dsc-basic: SKIP (0.000s)
[545.581678] [114/131] (476s left) syncobj_wait (multi-wait-all-submitted-signaled)
[545.641840] Starting subtest: multi-wait-all-submitted-signaled
[545.749543] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.108s)
[545.850525] [115/131] (476s left) gen9_exec_parse (unaligned-access)
[545.918612] Subtest unaligned-access: SKIP (0.000s)
[546.005393] [116/131] (476s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[546.101419] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[546.103722] Starting dynamic subtest: pipe-A-default-mode
[548.860223] Dynamic subtest pipe-A-default-mode: SUCCESS (2.760s)
[548.862871] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.762s)
[549.712465] [117/131] (472s left) gen7_exec_parse (bitmasks)
[549.788289] Subtest bitmasks: SKIP (0.000s)
[549.859836] [118/131] (472s left) i915_getparams_basic (basic-subslice-total)
[549.920913] Starting subtest: basic-subslice-total
[549.926123] Subtest basic-subslice-total: SUCCESS (0.000s)
[550.039773] [119/131] (472s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[550.144661] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[550.149318] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[550.292324] [120/131] (471s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[550.402616] Starting subtest: fb-8bpc-vs-panel-8bpc
[550.405181] Starting dynamic subtest: pipe-A-eDP-1
[550.708012] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.305s)
[550.711024] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.306s)
[551.539624] [121/131] (470s left) gem_eio (create-ext)
[551.773149] Starting subtest: create-ext
[552.103708] Subtest create-ext: SUCCESS (0.331s)
[552.262025] [122/131] (469s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[552.369640] Starting subtest: y-tiled-64bpp-rotate-180
[552.373840] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[552.503256] [123/131] (469s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[552.616378] Starting subtest: flip-vs-cursor-busy-crc-legacy
[553.409063] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.793s)
[554.272519] [124/131] (468s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[554.376488] Starting subtest: plane-scaler-unity-scaling-with-rotation
[554.378821] Starting dynamic subtest: pipe-A
[554.613453] Dynamic subtest pipe-A: SUCCESS (0.239s)
[554.622491] Starting dynamic subtest: pipe-B
[555.955066] Dynamic subtest pipe-B: SUCCESS (1.341s)
[555.964777] Starting dynamic subtest: pipe-C
[557.259018] Dynamic subtest pipe-C: SUCCESS (1.303s)
[557.268896] Starting dynamic subtest: pipe-D
[558.587781] Dynamic subtest pipe-D: SUCCESS (1.328s)
[558.590733] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.215s)
[559.795615] [125/131] (462s left) kms_flip (plain-flip-fb-recreate-interruptible)
[559.910535] Starting subtest: plain-flip-fb-recreate-interruptible
[559.913031] Starting dynamic subtest: A-eDP1
[568.774201] Dynamic subtest A-eDP1: SUCCESS (8.865s)
[568.783220] Starting dynamic subtest: B-eDP1
[577.604645] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[577.620612] Starting dynamic subtest: C-eDP1
[586.424205] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[586.434031] Starting dynamic subtest: D-eDP1
[595.246972] Dynamic subtest D-eDP1: SUCCESS (8.822s)
[595.252351] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.347s)
[596.439172] [126/131] (425s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[596.507993] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[596.613473] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[596.715289] [127/131] (425s left) gem_exec_schedule (thriceslice)
[596.794036] Starting subtest: thriceslice
[596.796287] Starting dynamic subtest: rcs0
[596.835893] Dynamic subtest rcs0: SUCCESS (0.052s)
[596.847910] Starting dynamic subtest: bcs0
[596.869604] Dynamic subtest bcs0: SUCCESS (0.032s)
[596.878691] Starting dynamic subtest: vcs0
[596.898452] Dynamic subtest vcs0: SUCCESS (0.028s)
[596.907064] Starting dynamic subtest: vcs1
[596.929599] Dynamic subtest vcs1: SUCCESS (0.030s)
[596.938174] Starting dynamic subtest: vecs0
[596.961373] Dynamic subtest vecs0: SUCCESS (0.031s)
[596.976734] Starting dynamic subtest: ccs0
[597.019470] Dynamic subtest ccs0: SUCCESS (0.055s)
[597.022182] Subtest thriceslice: SUCCESS (0.237s)
[598.372319] [128/131] (424s left) gem_exec_whisper (basic-queues-all)
[598.445939] Starting subtest: basic-queues-all
[609.531943] Subtest basic-queues-all: SUCCESS (11.084s)
[609.738404] [129/131] (412s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[609.879537] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[609.884167] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[610.011684] [130/131] (412s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[610.107016] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[614.699547] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.597s)
[615.925791] [131/131] (406s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[616.029204] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[616.033982] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[616.138482] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_hpd
results: parsing output: 1/ for test: gem_lmem_swapping
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_spin_batch
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: gem_mmap_offset
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: kms_joiner
results: parsing output: 15/ for test: gem_ccs
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_close
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_eio
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: i915_suspend
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: gem_exec_capture
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: syncobj_basic
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_prime
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_color
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_hdr
results: parsing output: 48/ for test: gem_softpin
results: parsing output: 49/ for test: gem_wait
results: parsing output: 50/ for test: kms_rotation_crc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_tiled_blits
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_legacy_colorkey
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: prime_vgem
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_ctx_exec
results: parsing output: 64/ for test: gem_ctx_engines
results: parsing output: 65/ for test: gem_partial_pwrite_pread
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_pxp
results: parsing output: 68/ for test: sysfs_heartbeat_interval
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: kms_pm_lpsp
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: gem_fenced_exec_thrash
results: parsing output: 73/ for test: gem_mmap_offset
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: gem_workarounds
results: parsing output: 80/ for test: kms_atomic_transition
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: gem_exec_params
results: parsing output: 83/ for test: kms_properties
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: gem_exec_whisper
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_atomic_transition
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: gem_exec_parallel
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_plane_multiple
results: parsing output: 101/ for test: i915_pm_rps
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_hdr
results: parsing output: 104/ for test: kms_getfb
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: prime_vgem
results: parsing output: 107/ for test: api_intel_allocator
results: parsing output: 108/ for test: kms_chamelium_color
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: drm_buddy
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_dsc
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: gen9_exec_parse
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: gen7_exec_parse
results: parsing output: 117/ for test: i915_getparams_basic
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_dither
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: gem_exec_whisper
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_frontbuffer_tracking
Done.