[57.193525] Initializing watchdogs
[57.193573]   /dev/watchdog0
[57.207526] [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]
[57.212283] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.214513] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.217855] [001/133] (960s left) gem_exec_schedule (preempt-queue-contexts-chain)
[57.323043] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[57.613512] [002/133] (960s left) gem_bad_reloc (negative-reloc)
[57.678767] Subtest negative-reloc: SKIP (0.000s)
[57.749646] [003/133] (960s left) gem_exec_flush (basic-batch-kernel-default-wb)
[57.818866] Starting subtest: basic-batch-kernel-default-wb
[64.270536] Subtest basic-batch-kernel-default-wb: SUCCESS (6.452s)
[64.453351] [004/133] (953s left) perf_pmu (enable-race)
[64.499304] Starting subtest: enable-race
[64.501543] Starting dynamic subtest: rcs0
[77.295128] Dynamic subtest rcs0: SUCCESS (12.797s)
[77.304513] Starting dynamic subtest: bcs0
[90.033566] Dynamic subtest bcs0: SUCCESS (12.737s)
[90.041500] Starting dynamic subtest: vcs0
[105.876079] Dynamic subtest vcs0: SUCCESS (15.840s)
[105.884961] Starting dynamic subtest: vcs1
[121.940477] Dynamic subtest vcs1: SUCCESS (16.063s)
[121.950229] Starting dynamic subtest: vecs0
[137.940239] Dynamic subtest vecs0: SUCCESS (15.999s)
[137.951946] Starting dynamic subtest: ccs0
[150.684389] Dynamic subtest ccs0: SUCCESS (12.742s)
[150.687144] Subtest enable-race: SUCCESS (86.185s)
[150.770972] [005/133] (867s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[150.891597] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[157.401953] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.514s)
[157.512563] [006/133] (860s left) syncobj_timeline (wait-any-complex)
[157.583886] Starting subtest: wait-any-complex
[157.645105] Subtest wait-any-complex: SUCCESS (0.062s)
[157.723697] [007/133] (860s left) gem_basic (create-fd-close)
[157.786883] Starting subtest: create-fd-close
[157.791160] Subtest create-fd-close: SUCCESS (0.000s)
[157.879308] [008/133] (860s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[157.965443] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[157.977372] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[158.051955] [009/133] (859s left) kms_plane_multiple (2x-tiling-4)
[158.141379] Starting subtest: 2x-tiling-4
[158.145981] Subtest 2x-tiling-4: SKIP (0.000s)
[158.212190] [010/133] (859s left) gem_exec_balancer (full-pulse)
[158.270886] Starting subtest: full-pulse
[162.742786] Subtest full-pulse: SUCCESS (4.471s)
[163.033512] [011/133] (855s left) sw_sync (alloc_timeline)
[163.066878] Starting subtest: alloc_timeline
[163.069312] Subtest alloc_timeline: SUCCESS (0.000s)
[163.120778] [012/133] (855s left) kms_psr (psr2-sprite-plane-move)
[163.209829] Starting subtest: psr2-sprite-plane-move
[163.212202] Starting dynamic subtest: eDP-1
[164.992642] Dynamic subtest eDP-1: SUCCESS (1.781s)
[164.995120] Subtest psr2-sprite-plane-move: SUCCESS (1.781s)
[165.836616] [013/133] (852s left) perf (invalid-remove-userspace-config)
[165.962448] Starting subtest: invalid-remove-userspace-config
[165.970959] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[166.022696] [014/133] (852s left) gem_pread (self)
[166.091756] Subtest self: SKIP (0.000s)
[166.157541] [015/133] (852s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[166.267398] Starting subtest: 4-tiled-16bpp-rotate-180
[167.512837] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.246s)
[167.633723] [016/133] (850s left) kms_flip (plain-flip-interruptible)
[167.734315] Starting subtest: plain-flip-interruptible
[167.736359] Starting dynamic subtest: A-eDP1
[169.438022] Dynamic subtest A-eDP1: SUCCESS (1.702s)
[169.446253] Starting dynamic subtest: B-eDP1
[171.066517] Dynamic subtest B-eDP1: SUCCESS (1.627s)
[171.077941] Starting dynamic subtest: C-eDP1
[172.692719] Dynamic subtest C-eDP1: SUCCESS (1.625s)
[172.702128] Starting dynamic subtest: D-eDP1
[174.326803] Dynamic subtest D-eDP1: SUCCESS (1.633s)
[174.331657] Subtest plain-flip-interruptible: SUCCESS (6.596s)
[175.484151] [017/133] (842s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[175.574516] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[175.579296] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[175.644255] [018/133] (842s left) gem_mmap_gtt (basic-write)
[175.712718] Subtest basic-write: SKIP (0.000s)
[175.782367] [019/133] (842s left) gem_userptr_blits (sync-unmap-cycles)
[175.846666] Starting subtest: sync-unmap-cycles
[181.220678] Subtest sync-unmap-cycles: SUCCESS (5.377s)
[181.325808] [020/133] (837s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[181.425904] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[181.429386] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[181.500658] [021/133] (836s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[181.593511] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[181.596945] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[181.683509] [022/133] (836s left) kms_rotation_crc (sprite-rotation-90)
[181.773128] Starting subtest: sprite-rotation-90
[181.776827] Subtest sprite-rotation-90: SKIP (0.001s)
[181.843771] [023/133] (836s left) drm_read (short-buffer-wakeup)
[181.987307] Starting subtest: short-buffer-wakeup
[214.205160] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[214.333807] [024/133] (804s left) kms_hdr (bpc-switch-dpms)
[214.436336] Starting subtest: bpc-switch-dpms
[215.467770] Starting dynamic subtest: pipe-A-eDP-1
[219.997882] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.530s)
[220.000362] Subtest bpc-switch-dpms: SUCCESS (5.564s)
[220.118037] [025/133] (798s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[220.217937] Starting subtest: fbc-shrfb-scaledprimary
[223.153696] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.940s)
[224.364952] [026/133] (794s left) kms_addfb_basic (basic-y-tiled-legacy)
[224.423121] Starting subtest: basic-y-tiled-legacy
[224.427824] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[224.560090] [027/133] (794s left) gem_exec_reloc (basic-write-cpu)
[224.616767] Subtest basic-write-cpu: SKIP (0.000s)
[224.683367] [028/133] (794s left) gem_eio (in-flight-internal-10ms)
[224.905070] Starting subtest: in-flight-internal-10ms
[225.949036] Subtest in-flight-internal-10ms: SUCCESS (1.044s)
[226.088790] [029/133] (792s left) gem_tiled_pread_pwrite
[226.208416] [030/133] (792s left) i915_pciid
[226.366598] [031/133] (792s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[226.461311] Starting subtest: multiplane-rotation-cropping-bottom
[244.051688] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.593s)
[244.151909] [032/133] (774s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[244.254080] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[244.257744] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[244.324219] [033/133] (774s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[244.395043] Starting subtest: multi-wait-all-for-submit-submitted
[244.505438] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.109s)
[244.578229] [034/133] (774s left) prime_vgem (sync)
[244.717573] Starting subtest: sync
[244.719640] Starting dynamic subtest: rcs0
[244.759489] Dynamic subtest rcs0: SUCCESS (0.044s)
[244.768253] Starting dynamic subtest: bcs0
[244.812377] Dynamic subtest bcs0: SUCCESS (0.052s)
[244.820244] Starting dynamic subtest: vcs0
[244.860094] Dynamic subtest vcs0: SUCCESS (0.047s)
[244.868039] Starting dynamic subtest: vcs1
[244.905438] Dynamic subtest vcs1: SUCCESS (0.045s)
[244.913295] Starting dynamic subtest: vecs0
[244.952564] Dynamic subtest vecs0: SUCCESS (0.046s)
[244.960360] Starting dynamic subtest: ccs0
[244.999725] Dynamic subtest ccs0: SUCCESS (0.046s)
[245.001946] Subtest sync: SUCCESS (0.285s)
[245.120493] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[245.124088] [035/133] (773s left) kms_plane (planar-pixel-format-settings)
[245.212282] Starting subtest: planar-pixel-format-settings
[245.285608] Subtest planar-pixel-format-settings: SUCCESS (0.072s)
[245.411199] [036/133] (773s left) gem_close_race (multigpu-basic-process)
[245.469767] Starting subtest: multigpu-basic-process
[245.474325] Subtest multigpu-basic-process: SKIP (0.000s)
[245.692475] [037/133] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[245.804722] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[245.808773] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[245.895830] [038/133] (773s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[245.988525] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[245.992882] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[246.112708] [039/133] (773s left) kms_cursor_crc (cursor-random-128x128)
[246.339189] Starting subtest: cursor-random-128x128
[246.346245] Starting dynamic subtest: pipe-A-eDP-1
[249.702340] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.354s)
[249.732144] Starting dynamic subtest: pipe-D-eDP-1
[253.666049] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.938s)
[253.668367] Subtest cursor-random-128x128: SUCCESS (7.324s)
[254.532592] [040/133] (764s left) kms_getfb (getfb-handle-zero)
[254.628951] Starting subtest: getfb-handle-zero
[254.631137] Subtest getfb-handle-zero: SUCCESS (0.000s)
[254.728466] [041/133] (764s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[254.818374] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[254.829139] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.010s)
[254.910326] [042/133] (764s left) gem_ctx_persistence (legacy-engines-mixed)
[254.984479] Starting subtest: legacy-engines-mixed
[254.986890] Starting dynamic subtest: render
[255.056611] Dynamic subtest render: SUCCESS (0.072s)
[255.067850] Starting dynamic subtest: bsd1
[255.111993] Dynamic subtest bsd1: SUCCESS (0.052s)
[255.123031] Starting dynamic subtest: bsd2
[255.153885] Dynamic subtest bsd2: SUCCESS (0.040s)
[255.163487] Starting dynamic subtest: blt
[255.204597] Dynamic subtest blt: SUCCESS (0.049s)
[255.214670] Starting dynamic subtest: vebox
[255.257243] Dynamic subtest vebox: SUCCESS (0.049s)
[255.260036] Subtest legacy-engines-mixed: SUCCESS (0.273s)
[255.361849] [043/133] (763s left) gem_exec_suspend (basic-s0)
[255.429721] Starting subtest: basic-S0
[255.432179] Starting dynamic subtest: smem
[275.778369] Dynamic subtest smem: SUCCESS (7.436s)
[275.781477] Subtest basic-S0: SUCCESS (7.438s)
[275.980054] [044/133] (743s left) kms_frontbuffer_tracking (fbc-2p-rte)
[276.093238] Starting subtest: fbc-2p-rte
[276.097781] Subtest fbc-2p-rte: SKIP (0.000s)
[276.193183] [045/133] (743s left) gem_exec_fence (submit-chain)
[276.372313] Starting subtest: submit-chain
[276.388248] Subtest submit-chain: SUCCESS (0.020s)
[277.911313] [046/133] (741s left) kms_setmode (invalid-clone-single-crtc-stealing)
[277.969486] Starting subtest: invalid-clone-single-crtc-stealing
[277.976159] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[278.081653] [047/133] (741s left) kms_flip (2x-dpms-vs-vblank-race)
[278.172223] Starting subtest: 2x-dpms-vs-vblank-race
[278.180859] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[278.265838] [048/133] (741s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[278.320767] Starting subtest: multi-wait-all-for-submit-available-submitted
[278.323079] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[278.414497] [049/133] (741s left) kms_addfb_basic (bad-pitch-65536)
[278.468603] Starting subtest: bad-pitch-65536
[278.470835] Subtest bad-pitch-65536: SUCCESS (0.000s)
[278.613284] [050/133] (741s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[278.682497] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[278.684675] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[278.792966] [051/133] (740s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[278.883201] Starting subtest: compare-crc-sanitycheck-nv12
[278.885258] Starting dynamic subtest: pipe-A-eDP-1
[279.564354] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.681s)
[279.574844] Starting dynamic subtest: pipe-B-eDP-1
[280.854746] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.288s)
[280.864435] Starting dynamic subtest: pipe-C-eDP-1
[282.071081] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.214s)
[282.081314] Starting dynamic subtest: pipe-D-eDP-1
[283.291409] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.217s)
[283.293770] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.407s)
[284.126193] [052/133] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[284.229249] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[291.311360] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.083s)
[291.488789] [053/133] (728s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[291.587440] Starting subtest: fbc-psr2-cursor-mmap-cpu
[291.589695] Starting dynamic subtest: eDP-1
[291.593564] Dynamic subtest eDP-1: SKIP (0.000s)
[291.597511] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[291.657966] [054/133] (728s left) kms_chamelium_color (ctm-limited-range)
[291.750524] Subtest ctm-limited-range: SKIP (0.000s)
[291.794867] [055/133] (728s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[291.914101] Starting subtest: cursor-vs-flip-atomic-transitions
[321.852673] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.939s)
[322.684429] [056/133] (697s left) kms_plane (pixel-format-4-tiled-modifier)
[322.782027] Starting subtest: pixel-format-4-tiled-modifier
[322.809551] Starting dynamic subtest: pipe-A-plane-0
[323.498286] Dynamic subtest pipe-A-plane-0: SUCCESS (0.689s)
[323.509896] Starting dynamic subtest: pipe-A-plane-3
[323.930978] Dynamic subtest pipe-A-plane-3: SUCCESS (0.431s)
[323.939430] Starting dynamic subtest: pipe-A-plane-5
[323.942914] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[325.063255] Starting dynamic subtest: pipe-B-plane-0
[325.710532] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[325.723489] Starting dynamic subtest: pipe-B-plane-3
[326.144004] Dynamic subtest pipe-B-plane-3: SUCCESS (0.430s)
[326.152950] Starting dynamic subtest: pipe-B-plane-5
[326.156480] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[326.472313] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.690s)
[327.351849] [057/133] (692s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[327.461133] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[328.063446] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.604s)
[328.234630] [058/133] (691s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[328.281517] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[328.388346] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[328.463667] [059/133] (691s left) kms_properties (crtc-properties-legacy)
[328.547288] Starting subtest: crtc-properties-legacy
[328.549172] Starting dynamic subtest: pipe-A-eDP-1
[328.978629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.432s)
[328.989017] Starting dynamic subtest: pipe-B-eDP-1
[330.117508] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.137s)
[330.127890] Starting dynamic subtest: pipe-C-eDP-1
[331.238762] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[331.248041] Starting dynamic subtest: pipe-D-eDP-1
[332.370084] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[332.372040] Subtest crtc-properties-legacy: SUCCESS (3.822s)
[333.180901] [060/133] (686s left) syncobj_wait (wait-any-snapshot)
[333.240890] Starting subtest: wait-any-snapshot
[333.322143] Subtest wait-any-snapshot: SUCCESS (0.082s)
[333.399027] [061/133] (686s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[333.499564] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[333.501889] Starting dynamic subtest: pipe-A-eDP-1
[333.525049] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[333.536116] Starting dynamic subtest: pipe-B-eDP-1
[333.558251] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[333.566696] Starting dynamic subtest: pipe-C-eDP-1
[333.587662] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[333.595994] Starting dynamic subtest: pipe-D-eDP-1
[333.617981] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[333.622355] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[335.739180] [062/133] (684s left) kms_flip (flip-vs-suspend-interruptible)
[335.847024] Starting subtest: flip-vs-suspend-interruptible
[335.849446] Starting dynamic subtest: A-eDP1
[384.730095] Dynamic subtest A-eDP1: SUCCESS (4.565s)
[384.742740] Starting dynamic subtest: B-eDP1
[433.721368] Dynamic subtest B-eDP1: SUCCESS (4.459s)
[433.739716] Starting dynamic subtest: C-eDP1
[482.737077] Dynamic subtest C-eDP1: SUCCESS (4.532s)
[482.750349] Starting dynamic subtest: D-eDP1
[531.704200] Dynamic subtest D-eDP1: SUCCESS (4.449s)
[531.706633] Subtest flip-vs-suspend-interruptible: SUCCESS (18.021s)
[532.898743] [063/133] (487s left) kms_invalid_mode (bad-hsync-end)
[533.000003] Starting subtest: bad-hsync-end
[533.003612] Starting dynamic subtest: pipe-A-eDP-1
[533.287819] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[533.297985] Starting dynamic subtest: pipe-B-eDP-1
[533.300363] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[533.311386] Starting dynamic subtest: pipe-C-eDP-1
[533.313884] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[533.323871] Starting dynamic subtest: pipe-D-eDP-1
[533.326158] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[533.328395] Subtest bad-hsync-end: SUCCESS (0.291s)
[534.140925] [064/133] (486s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[534.256439] Starting subtest: psr-rgb565-draw-pwrite
[541.244615] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.985s)
[541.370734] [065/133] (478s left) kms_big_fb (x-tiled-addfb)
[541.476286] Starting subtest: x-tiled-addfb
[541.478598] Subtest x-tiled-addfb: SUCCESS (0.000s)
[541.597939] [066/133] (478s left) kms_content_protection (atomic-dpms)
[541.741302] Starting subtest: atomic-dpms
[541.746063] Subtest atomic-dpms: SKIP (0.000s)
[541.854689] [067/133] (478s left) kms_color (ctm-signed)
[541.948795] Starting subtest: ctm-signed
[541.950663] Starting dynamic subtest: pipe-A-eDP-1
[544.019604] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.072s)
[544.031542] Starting dynamic subtest: pipe-B-eDP-1
[546.809411] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.787s)
[546.824979] Starting dynamic subtest: pipe-C-eDP-1
[549.523400] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.711s)
[549.532750] Starting dynamic subtest: pipe-D-eDP-1
[552.188391] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.663s)
[552.190649] Subtest ctm-signed: SUCCESS (10.235s)
[553.012492] [068/133] (467s left) kms_atomic_interruptible (legacy-setmode)
[553.114668] Starting subtest: legacy-setmode
[553.117009] Starting dynamic subtest: pipe-A-eDP-1
[559.980507] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.863s)
[559.982980] Subtest legacy-setmode: SUCCESS (6.865s)
[560.782030] [069/133] (459s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[560.899745] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[567.930836] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.032s)
[568.054678] [070/133] (452s left) api_intel_allocator (reserve-simple)
[568.193183] Starting subtest: reserve-simple
[568.195538] Subtest reserve-simple: SUCCESS (0.004s)
[568.320372] [071/133] (452s left) gem_exec_async (forked-writes)
[568.383003] Starting subtest: forked-writes
[568.385473] Starting dynamic subtest: rcs0
[568.408735] Dynamic subtest rcs0: SUCCESS (0.025s)
[568.423870] Starting dynamic subtest: bcs0
[568.434294] Dynamic subtest bcs0: SUCCESS (0.023s)
[568.444031] Starting dynamic subtest: vcs0
[568.459906] Dynamic subtest vcs0: SUCCESS (0.024s)
[568.470876] Starting dynamic subtest: vcs1
[568.483879] Dynamic subtest vcs1: SUCCESS (0.023s)
[568.493418] Starting dynamic subtest: vecs0
[568.506741] Dynamic subtest vecs0: SUCCESS (0.022s)
[568.516508] Starting dynamic subtest: ccs0
[568.528833] Dynamic subtest ccs0: SUCCESS (0.021s)
[568.531149] Subtest forked-writes: SUCCESS (0.147s)
[568.757840] [072/133] (451s left) sysfs_preempt_timeout (timeout)
[568.812750] Starting subtest: timeout
[568.815217] Starting dynamic subtest: vecs0
[578.661304] Dynamic subtest vecs0: SUCCESS (9.843s)
[578.673649] Starting dynamic subtest: ccs0
[579.976451] Dynamic subtest ccs0: SUCCESS (1.315s)
[579.985718] Starting dynamic subtest: vcs0
[589.601425] Dynamic subtest vcs0: SUCCESS (9.619s)
[589.612260] Starting dynamic subtest: bcs0
[590.819764] Dynamic subtest bcs0: SUCCESS (1.218s)
[590.836665] Starting dynamic subtest: rcs0
[592.045153] Dynamic subtest rcs0: SUCCESS (1.224s)
[592.060519] Starting dynamic subtest: vcs1
[601.633855] Dynamic subtest vcs1: SUCCESS (9.581s)
[601.636971] Subtest timeout: SUCCESS (32.813s)
[601.715247] [073/133] (418s left) syncobj_wait (single-wait-for-submit-signaled)
[601.768392] Starting subtest: single-wait-for-submit-signaled
[601.770709] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[601.876826] [074/133] (418s left) kms_pm_dc (dc5-dpms-negative)
[602.993407] Starting subtest: dc5-dpms-negative
[602.998012] Subtest dc5-dpms-negative: SKIP (0.000s)
[603.078875] [075/133] (417s left) kms_addfb_basic (no-handle)
[603.137767] Starting subtest: no-handle
[603.140161] Subtest no-handle: SUCCESS (0.000s)
[603.262179] [076/133] (417s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[603.370491] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[603.375051] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[603.473698] [077/133] (417s left) gem_exec_schedule (deep)
[603.651673] Starting subtest: deep
[603.654271] Starting dynamic subtest: rcs0
[608.795151] Dynamic subtest rcs0: SKIP (5.139s)
[608.805362] Starting dynamic subtest: vcs0
[619.114924] Dynamic subtest vcs0: SUCCESS (10.318s)
[619.124960] Starting dynamic subtest: vcs1
[630.128970] Dynamic subtest vcs1: SUCCESS (11.011s)
[630.139942] Starting dynamic subtest: vecs0
[640.935889] Dynamic subtest vecs0: SUCCESS (10.808s)
[640.946997] Starting dynamic subtest: ccs0
[654.238052] Dynamic subtest ccs0: SUCCESS (13.301s)
[654.241944] Subtest deep: SUCCESS (50.583s)
[655.622237] [078/133] (365s left) kms_chamelium_edid (dp-edid-resolution-list)
[656.019765] Subtest dp-edid-resolution-list: SKIP (0.000s)
[656.809415] [079/133] (364s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[656.908935] Starting subtest: y-tiled-64bpp-rotate-90
[656.913276] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[657.004756] [080/133] (363s left) kms_draw_crc (draw-method-blt)
[657.100251] Starting subtest: draw-method-blt
[657.102672] Starting dynamic subtest: xrgb8888-untiled
[657.324775] Dynamic subtest xrgb8888-untiled: SUCCESS (0.225s)
[657.334579] Starting dynamic subtest: rgb565-untiled
[657.546902] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[657.556800] Starting dynamic subtest: xrgb2101010-untiled
[657.747061] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[657.756970] Starting dynamic subtest: xbgr16161616f-untiled
[657.957548] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[657.968976] Starting dynamic subtest: xrgb8888-xtiled
[658.079894] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.120s)
[658.091500] Starting dynamic subtest: rgb565-xtiled
[658.193784] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[658.202756] Starting dynamic subtest: xrgb2101010-xtiled
[658.291001] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.098s)
[658.300922] Starting dynamic subtest: xbgr16161616f-xtiled
[658.402523] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[658.413544] Starting dynamic subtest: xrgb8888-4tiled
[658.513606] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.109s)
[658.525110] Starting dynamic subtest: rgb565-4tiled
[658.624222] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[658.636174] Starting dynamic subtest: xrgb2101010-4tiled
[658.735812] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.109s)
[658.745509] Starting dynamic subtest: xbgr16161616f-4tiled
[658.846832] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[658.848908] Subtest draw-method-blt: SUCCESS (1.748s)
[658.967895] [081/133] (361s left) gem_wait (wait)
[659.036793] Starting subtest: wait
[659.038446] Starting dynamic subtest: all-engines
[660.645179] Dynamic subtest all-engines: SUCCESS (1.608s)
[660.658305] Starting dynamic subtest: rcs0
[661.692022] Dynamic subtest rcs0: SUCCESS (1.046s)
[661.704702] Starting dynamic subtest: bcs0
[662.739014] Dynamic subtest bcs0: SUCCESS (1.045s)
[662.751207] Starting dynamic subtest: vcs0
[663.785105] Dynamic subtest vcs0: SUCCESS (1.043s)
[663.797538] Starting dynamic subtest: vcs1
[664.831074] Dynamic subtest vcs1: SUCCESS (1.044s)
[664.843270] Starting dynamic subtest: vecs0
[665.876732] Dynamic subtest vecs0: SUCCESS (1.044s)
[665.889645] Starting dynamic subtest: ccs0
[666.925065] Dynamic subtest ccs0: SUCCESS (1.045s)
[666.927502] Subtest wait: SUCCESS (7.891s)
[667.122156] [082/133] (353s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[667.232911] Starting subtest: pipe-fbc-rte
[667.239816] Starting dynamic subtest: pipe-B-eDP-1
[672.681864] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.452s)
[672.689189] Subtest pipe-fbc-rte: SUCCESS (5.454s)
[674.968712] [083/133] (346s left) kms_vblank (query-busy-hang)
[675.071280] Starting subtest: query-busy-hang
[675.073141] Starting dynamic subtest: pipe-A-eDP-1
[702.375230] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.298s)
[702.389868] Starting dynamic subtest: pipe-D-eDP-1
[717.421089] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.041s)
[717.423516] Subtest query-busy-hang: SUCCESS (42.343s)
[718.216552] [084/133] (302s left) kms_addfb_basic (too-high)
[718.311169] Starting subtest: too-high
[718.313466] Subtest too-high: SUCCESS (0.000s)
[718.414889] [085/133] (302s left) i915_drm_fdinfo (busy-check-all)
[718.452794] Starting subtest: busy-check-all
[718.455132] Starting dynamic subtest: rcs0
[718.459601] Dynamic subtest rcs0: SKIP (0.003s)
[718.474951] Starting dynamic subtest: bcs0
[718.479212] Dynamic subtest bcs0: SKIP (0.000s)
[718.487962] Starting dynamic subtest: vcs0
[718.491912] Dynamic subtest vcs0: SKIP (0.000s)
[718.500296] Starting dynamic subtest: vcs1
[718.504218] Dynamic subtest vcs1: SKIP (0.000s)
[718.512789] Starting dynamic subtest: vecs0
[718.516767] Dynamic subtest vecs0: SKIP (0.000s)
[718.525394] Starting dynamic subtest: ccs0
[718.529395] Dynamic subtest ccs0: SKIP (0.000s)
[718.533386] Subtest busy-check-all: SKIP (0.008s)
[718.570237] [086/133] (302s left) kms_psr (fbc-pr-primary-mmap-cpu)
[718.692643] Starting subtest: fbc-pr-primary-mmap-cpu
[718.696995] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[718.785967] [087/133] (302s left) kms_psr (pr-primary-render)
[718.889596] Starting subtest: pr-primary-render
[718.893910] Subtest pr-primary-render: SKIP (0.000s)
[718.963860] [088/133] (302s left) kms_cursor_crc (cursor-tearing-position-change)
[719.076377] Starting subtest: cursor-tearing-position-change
[719.078166] Starting dynamic subtest: pipe-A-eDP-1
[719.655877] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[719.669361] Starting dynamic subtest: pipe-D-eDP-1
[720.852119] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.197s)
[720.854596] Subtest cursor-tearing-position-change: SUCCESS (1.777s)
[721.689029] [089/133] (299s left) vgem_basic (dmabuf-fence-before)
[721.739788] Starting subtest: dmabuf-fence-before
[721.741870] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[721.799220] [090/133] (299s left) gem_eio (in-flight-contexts-immediate)
[721.993548] Starting subtest: in-flight-contexts-immediate
[733.699022] Subtest in-flight-contexts-immediate: SUCCESS (11.702s)
[733.861643] [091/133] (287s left) kms_flip (2x-plain-flip-ts-check)
[733.959689] Starting subtest: 2x-plain-flip-ts-check
[733.968387] Subtest 2x-plain-flip-ts-check: SKIP (0.010s)
[734.047011] [092/133] (287s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[734.159499] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[734.163967] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[734.248789] [093/133] (287s left) gem_lmem_swapping (random)
[734.297061] Subtest random: SKIP (0.000s)
[734.339316] [094/133] (287s left) kms_cursor_crc (cursor-size-change)
[734.436287] Starting subtest: cursor-size-change
[734.438589] Starting dynamic subtest: pipe-A-eDP-1
[735.263213] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.825s)
[735.272883] Starting dynamic subtest: pipe-D-eDP-1
[736.787813] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.524s)
[736.790098] Subtest cursor-size-change: SUCCESS (2.352s)
[737.669371] [095/133] (283s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[737.768866] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[737.773269] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[737.879149] [096/133] (283s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[737.948962] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[737.954024] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[738.135664] [097/133] (283s left) gem_pxp (reject-modify-context-protection-off-2)
[738.254748] Starting subtest: reject-modify-context-protection-off-2
[738.257064] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[738.360572] [098/133] (283s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[738.450839] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[738.455021] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[738.538292] [099/133] (283s left) i915_pm_rpm (gem-idle)
[740.772768] Starting subtest: gem-idle
[746.985504] Subtest gem-idle: SUCCESS (6.214s)
[747.312133] [100/133] (274s left) perf (blocking-parameterized)
[747.414134] Starting subtest: blocking-parameterized
[767.433895] Subtest blocking-parameterized: SUCCESS (20.019s)
[767.482569] [101/133] (254s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[767.539874] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[767.542390] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[767.654219] [102/133] (254s left) kms_plane_scaling (planes-upscale-20x20)
[767.762583] Starting subtest: planes-upscale-20x20
[767.764839] Starting dynamic subtest: pipe-A
[767.823996] Dynamic subtest pipe-A: SUCCESS (0.062s)
[767.835134] Starting dynamic subtest: pipe-B
[768.941633] Dynamic subtest pipe-B: SUCCESS (1.116s)
[768.952483] Starting dynamic subtest: pipe-C
[770.050850] Dynamic subtest pipe-C: SUCCESS (1.108s)
[770.060383] Starting dynamic subtest: pipe-D
[771.202001] Dynamic subtest pipe-D: SUCCESS (1.150s)
[771.204398] Subtest planes-upscale-20x20: SUCCESS (3.442s)
[772.349474] [103/133] (249s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[772.406137] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[772.513565] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[772.587354] [104/133] (249s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[772.687925] Starting subtest: pr-cursor-plane-update-sf
[772.692059] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[772.757866] [105/133] (249s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[774.780540] Starting subtest: modeset-lpsp-stress-no-wait
[784.942236] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.165s)
[785.019521] [106/133] (236s left) kms_psr (fbc-psr2-sprite-render)
[785.113948] Starting subtest: fbc-psr2-sprite-render
[785.116314] Starting dynamic subtest: eDP-1
[785.120816] Dynamic subtest eDP-1: SKIP (0.000s)
[785.125353] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[785.202804] [107/133] (236s left) kms_display_modes (extended-mode-basic)
[785.302778] Starting subtest: extended-mode-basic
[785.311601] Subtest extended-mode-basic: SKIP (0.000s)
[785.359000] [108/133] (236s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[785.468263] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[785.472389] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[785.568513] [109/133] (236s left) perf (enable-disable)
[785.669662] Starting subtest: enable-disable
[785.671775] Starting dynamic subtest: 0-rcs0
[787.905709] Dynamic subtest 0-rcs0: SUCCESS (2.234s)
[787.915980] Starting dynamic subtest: 1-vecs0
[792.342020] Dynamic subtest 1-vecs0: SUCCESS (4.435s)
[792.344646] Subtest enable-disable: SUCCESS (6.671s)
[792.389946] [110/133] (229s left) kms_vblank (ts-continuation-modeset-hang)
[792.493521] Starting subtest: ts-continuation-modeset-hang
[792.495619] Starting dynamic subtest: pipe-A-eDP-1
[819.425784] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.933s)
[819.440420] Starting dynamic subtest: pipe-D-eDP-1
[834.421224] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.992s)
[834.424062] Subtest ts-continuation-modeset-hang: SUCCESS (41.929s)
[835.225405] [111/133] (187s left) api_intel_bb (misplaced-blitter)
[835.280315] Starting subtest: misplaced-blitter
[835.286556] Subtest misplaced-blitter: SUCCESS (0.008s)
[835.395339] [112/133] (186s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[835.497360] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[835.499679] Starting dynamic subtest: pipe-A-eDP-1
[835.558373] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[835.569860] Starting dynamic subtest: pipe-B-eDP-1
[835.628299] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[835.640151] Starting dynamic subtest: pipe-C-eDP-1
[835.696611] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[835.707401] Starting dynamic subtest: pipe-D-eDP-1
[835.763745] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[835.768150] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[837.714505] [113/133] (184s left) gem_exec_schedule (preempt-contexts)
[837.791995] Starting subtest: preempt-contexts
[837.794437] Starting dynamic subtest: rcs0
[837.842731] Dynamic subtest rcs0: SUCCESS (0.060s)
[837.852583] Starting dynamic subtest: bcs0
[837.895489] Dynamic subtest bcs0: SUCCESS (0.052s)
[837.906037] Starting dynamic subtest: vcs0
[837.944665] Dynamic subtest vcs0: SUCCESS (0.049s)
[837.957581] Starting dynamic subtest: vcs1
[837.996233] Dynamic subtest vcs1: SUCCESS (0.051s)
[838.006903] Starting dynamic subtest: vecs0
[838.048168] Dynamic subtest vecs0: SUCCESS (0.051s)
[838.061971] Starting dynamic subtest: ccs0
[838.111341] Dynamic subtest ccs0: SUCCESS (0.062s)
[838.113514] Subtest preempt-contexts: SUCCESS (0.329s)
[839.738238] [114/133] (182s left) gem_ctx_isolation (dirty-switch)
[839.800050] Starting subtest: dirty-switch
[839.802291] Starting dynamic subtest: rcs0
[839.973717] Dynamic subtest rcs0: SUCCESS (0.177s)
[839.985371] Starting dynamic subtest: bcs0
[840.186235] Dynamic subtest bcs0: SUCCESS (0.212s)
[840.198034] Starting dynamic subtest: vcs0
[840.429399] Dynamic subtest vcs0: SUCCESS (0.242s)
[840.443215] Starting dynamic subtest: vcs1
[841.836109] Dynamic subtest vcs1: SUCCESS (1.405s)
[841.848089] Starting dynamic subtest: vecs0
[843.821370] Dynamic subtest vecs0: SUCCESS (1.984s)
[843.835977] Starting dynamic subtest: ccs0
[845.881719] Dynamic subtest ccs0: SUCCESS (2.059s)
[845.884181] Subtest dirty-switch: SUCCESS (6.085s)
[846.120689] [115/133] (176s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[846.176321] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[846.281264] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[846.362790] [116/133] (176s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[846.465950] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[847.279700] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.814s)
[847.443402] [117/133] (175s left) kms_chamelium_hpd (vga-hpd-fast)
[847.831985] Subtest vga-hpd-fast: SKIP (0.000s)
[848.617388] [118/133] (173s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[848.702321] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[848.704535] Starting dynamic subtest: pipe-A-eDP-1
[848.726144] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[848.736479] Starting dynamic subtest: pipe-B-eDP-1
[848.757946] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[848.769436] Starting dynamic subtest: pipe-C-eDP-1
[848.790842] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[848.803036] Starting dynamic subtest: pipe-D-eDP-1
[848.824899] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[848.828901] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[850.914182] [119/133] (171s left) gem_gpgpu_fill (offset-16x16)
[850.972751] Starting subtest: offset-16x16
[850.977685] Subtest offset-16x16: SUCCESS (0.007s)
[851.123726] [120/133] (171s left) kms_big_fb (linear-64bpp-rotate-180)
[851.218172] Starting subtest: linear-64bpp-rotate-180
[852.788545] Subtest linear-64bpp-rotate-180: SUCCESS (1.571s)
[852.966240] [121/133] (169s left) gem_exec_balancer (parallel-contexts)
[853.225623] Starting subtest: parallel-contexts
[856.796927] Subtest parallel-contexts: SUCCESS (3.571s)
[856.962438] [122/133] (165s left) gem_userptr_blits (create-destroy-sync)
[857.033678] Starting subtest: create-destroy-sync
[862.043094] Subtest create-destroy-sync: SUCCESS (5.008s)
[862.164695] [123/133] (160s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[862.260479] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[862.264460] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[862.374943] [124/133] (160s left) gem_mmap_gtt (basic-small-bo-tiledx)
[862.424206] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[862.482731] [125/133] (160s left) kms_cursor_crc (cursor-onscreen-256x256)
[862.755731] Starting subtest: cursor-onscreen-256x256
[862.761804] Starting dynamic subtest: pipe-A-eDP-1
[864.896007] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.136s)
[864.929131] Starting dynamic subtest: pipe-D-eDP-1
[867.697023] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.779s)
[867.699258] Subtest cursor-onscreen-256x256: SUCCESS (4.941s)
[868.489530] [126/133] (154s left) gem_spin_batch (engines)
[868.550035] Starting subtest: engines
[868.552310] Starting dynamic subtest: rcs0
[871.791266] Dynamic subtest rcs0: SUCCESS (3.236s)
[871.804141] Starting dynamic subtest: bcs0
[875.029066] Dynamic subtest bcs0: SUCCESS (3.235s)
[875.039755] Starting dynamic subtest: vcs0
[878.266284] Dynamic subtest vcs0: SUCCESS (3.234s)
[878.277095] Starting dynamic subtest: vcs1
[881.507466] Dynamic subtest vcs1: SUCCESS (3.237s)
[881.520021] Starting dynamic subtest: vecs0
[884.743758] Dynamic subtest vecs0: SUCCESS (3.233s)
[884.756883] Starting dynamic subtest: ccs0
[887.977284] Dynamic subtest ccs0: SUCCESS (3.231s)
[887.979700] Subtest engines: SUCCESS (19.422s)
[888.204850] [127/133] (134s left) gen9_exec_parse (bb-start-far)
[888.273811] Subtest bb-start-far: SKIP (0.000s)
[888.349231] [128/133] (134s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[888.453641] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[888.455944] Starting dynamic subtest: pipe-A-eDP-1
[888.478741] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[888.493651] Starting dynamic subtest: pipe-B-eDP-1
[888.514433] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[888.523769] Starting dynamic subtest: pipe-C-eDP-1
[888.545239] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[888.554553] Starting dynamic subtest: pipe-D-eDP-1
[888.575985] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[888.580384] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[890.681693] [129/133] (132s left) kms_lease (implicit-plane-lease)
[890.787720] Starting subtest: implicit-plane-lease
[890.790197] Subtest implicit-plane-lease: SUCCESS (0.003s)
[890.903943] [130/133] (132s left) i915_pm_rps (waitboost)
[890.980883] Starting subtest: waitboost
[897.073280] Subtest waitboost: SUCCESS (6.092s)
[897.189697] [131/133] (125s left) syncobj_basic (bad-flags-handle-to-fd)
[897.249851] Starting subtest: bad-flags-handle-to-fd
[897.252249] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[897.364796] [132/133] (125s left) gem_mmap_offset (clear)
[897.425214] Starting subtest: clear
[897.427603] Starting dynamic subtest: smem0
[923.055585] Dynamic subtest smem0: SUCCESS (25.628s)
[923.057838] Subtest clear: SUCCESS (25.630s)
[923.195416] [133/133] ( 99s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[923.341686] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[923.346054] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[923.427934] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: gem_bad_reloc
results: parsing output: 2/ for test: gem_exec_flush
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: gem_basic
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_plane_multiple
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: sw_sync
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: perf
results: parsing output: 13/ for test: gem_pread
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_rotation_crc
results: parsing output: 22/ for test: drm_read
results: parsing output: 23/ for test: kms_hdr
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: gem_tiled_pread_pwrite
results: parsing output: 29/ for test: i915_pciid
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: prime_vgem
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: gem_close_race
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: kms_getfb
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: gem_exec_suspend
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_fence
results: parsing output: 45/ for test: kms_setmode
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_pipe_crc_basic
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_chamelium_color
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_properties
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_invalid_mode
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_content_protection
results: parsing output: 66/ for test: kms_color
results: parsing output: 67/ for test: kms_atomic_interruptible
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: api_intel_allocator
results: parsing output: 70/ for test: gem_exec_async
results: parsing output: 71/ for test: sysfs_preempt_timeout
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: kms_pm_dc
results: parsing output: 74/ for test: kms_addfb_basic
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: kms_chamelium_edid
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_draw_crc
results: parsing output: 80/ for test: gem_wait
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_vblank
results: parsing output: 83/ for test: kms_addfb_basic
results: parsing output: 84/ for test: i915_drm_fdinfo
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: vgem_basic
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: gem_pxp
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: i915_pm_rpm
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_plane_scaling
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: kms_pm_rpm
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_display_modes
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: gem_ctx_isolation
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_chamelium_hpd
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: gem_gpgpu_fill
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: gem_userptr_blits
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: gem_spin_batch
results: parsing output: 126/ for test: gen9_exec_parse
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: i915_pm_rps
results: parsing output: 130/ for test: syncobj_basic
results: parsing output: 131/ for test: gem_mmap_offset
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.