[62.719611] Initializing watchdogs
[62.719662]   /dev/watchdog0
[62.734958] [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]
[62.739405] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.741629] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.744850] [001/132] (960s left) kms_atomic (plane-primary-legacy)
[62.868156] Starting subtest: plane-primary-legacy
[62.870507] Starting dynamic subtest: pipe-A-eDP-1
[63.388290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.515s)
[63.390623] Subtest plane-primary-legacy: SUCCESS (0.516s)
[64.253308] [002/132] (959s left) gem_reg_read (timestamp-monotonic)
[64.307311] Starting subtest: timestamp-monotonic
[68.549606] Subtest timestamp-monotonic: SUCCESS (4.228s)
[68.634779] [003/132] (954s left) gem_softpin (allocator-evict)
[68.702473] Starting subtest: allocator-evict
[68.704927] Starting dynamic subtest: rcs0
[92.848627] Dynamic subtest rcs0: SUCCESS (24.127s)
[92.857350] Starting dynamic subtest: bcs0
[116.787926] Dynamic subtest bcs0: SUCCESS (23.935s)
[116.797202] Starting dynamic subtest: vcs0
[140.644447] Dynamic subtest vcs0: SUCCESS (23.854s)
[140.654074] Starting dynamic subtest: vcs1
[164.166932] Dynamic subtest vcs1: SUCCESS (23.524s)
[164.175555] Starting dynamic subtest: vecs0
[187.874128] Dynamic subtest vecs0: SUCCESS (23.707s)
[187.884310] Starting dynamic subtest: ccs0
[211.783614] Dynamic subtest ccs0: SUCCESS (23.909s)
[211.786104] Subtest allocator-evict: SUCCESS (143.059s)
[211.866195] [004/132] (811s left) gem_ctx_engines (invalid-engines)
[211.978513] Starting subtest: invalid-engines
[211.989853] Subtest invalid-engines: SUCCESS (0.012s)
[212.223895] [005/132] (811s left) gem_exec_capture (capture)
[212.294784] Starting subtest: capture
[212.297189] Starting dynamic subtest: rcs0-smem
[213.137326] Dynamic subtest rcs0-smem: SUCCESS (0.842s)
[213.148299] Starting dynamic subtest: bcs0-smem
[213.966032] Dynamic subtest bcs0-smem: SUCCESS (0.826s)
[213.976479] Starting dynamic subtest: vcs0-smem
[214.785026] Dynamic subtest vcs0-smem: SUCCESS (0.821s)
[214.793825] Starting dynamic subtest: vcs1-smem
[216.111089] Dynamic subtest vcs1-smem: SUCCESS (1.324s)
[216.119647] Starting dynamic subtest: vecs0-smem
[217.006488] Dynamic subtest vecs0-smem: FAIL (0.836s)
[217.016348] Starting dynamic subtest: ccs0-smem
[218.271426] Dynamic subtest ccs0-smem: SUCCESS (1.323s)
[218.273931] Subtest capture: FAIL (5.974s)
[218.382822] [006/132] (805s left) kms_debugfs (display-off-read-all)
[218.493068] Starting subtest: display-off-read-all
[218.783306] Subtest display-off-read-all: SUCCESS (0.290s)
[219.604415] [007/132] (803s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[219.705884] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[219.708327] Starting dynamic subtest: pipe-A-eDP-1
[219.730540] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[219.740215] Starting dynamic subtest: pipe-B-eDP-1
[219.761262] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[219.769426] Starting dynamic subtest: pipe-C-eDP-1
[219.790439] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[219.800304] Starting dynamic subtest: pipe-D-eDP-1
[219.822809] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[219.827268] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[221.938857] [008/132] (801s left) perf_pmu (busy-accuracy-50)
[221.985428] Starting subtest: busy-accuracy-50
[221.987433] Starting dynamic subtest: rcs0
[223.517889] Dynamic subtest rcs0: SUCCESS (1.531s)
[223.529073] Starting dynamic subtest: bcs0
[225.058555] Dynamic subtest bcs0: SUCCESS (1.540s)
[225.070500] Starting dynamic subtest: vcs0
[226.601977] Dynamic subtest vcs0: SUCCESS (1.542s)
[226.613040] Starting dynamic subtest: vcs1
[228.142756] Dynamic subtest vcs1: SUCCESS (1.540s)
[228.154531] Starting dynamic subtest: vecs0
[229.681846] Dynamic subtest vecs0: SUCCESS (1.538s)
[229.693257] Starting dynamic subtest: ccs0
[231.226187] Dynamic subtest ccs0: SUCCESS (1.544s)
[231.228596] Subtest busy-accuracy-50: SUCCESS (9.240s)
[231.341580] [009/132] (792s left) kms_flip (plain-flip-fb-recreate-interruptible)
[231.447569] Starting subtest: plain-flip-fb-recreate-interruptible
[231.449869] Starting dynamic subtest: A-eDP1
[240.321339] Dynamic subtest A-eDP1: SUCCESS (8.873s)
[240.331886] Starting dynamic subtest: B-eDP1
[249.150550] Dynamic subtest B-eDP1: SUCCESS (8.827s)
[249.162331] Starting dynamic subtest: C-eDP1
[257.966122] Dynamic subtest C-eDP1: SUCCESS (8.815s)
[257.975391] Starting dynamic subtest: D-eDP1
[266.797394] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[266.801794] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.354s)
[267.986556] [010/132] (755s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[268.054046] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[268.056267] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[268.128706] [011/132] (755s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[268.217403] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[268.221894] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[268.338610] [012/132] (755s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[268.441838] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[268.446180] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[268.505676] [013/132] (755s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[268.606405] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[269.673370] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.068s)
[269.797200] [014/132] (753s left) gem_exec_reloc (basic-gtt-active)
[269.852269] Subtest basic-gtt-active: SKIP (0.000s)
[269.915482] [015/132] (753s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[270.008042] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[270.011520] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[270.089851] [016/132] (753s left) gem_ppgtt (shrink-vs-evict-any)
[270.138251] Starting subtest: shrink-vs-evict-any
[277.266694] Subtest shrink-vs-evict-any: SUCCESS (7.126s)
[277.339130] [017/132] (746s left) sysfs_timeslice_duration (timeout)
[277.396520] Starting subtest: timeout
[277.398942] Starting dynamic subtest: vecs0
[287.289282] Dynamic subtest vecs0: SUCCESS (9.889s)
[287.300862] Starting dynamic subtest: ccs0
[288.504615] Dynamic subtest ccs0: SUCCESS (1.215s)
[288.515612] Starting dynamic subtest: vcs0
[298.296819] Dynamic subtest vcs0: SUCCESS (9.791s)
[298.308352] Starting dynamic subtest: bcs0
[298.848052] Dynamic subtest bcs0: SUCCESS (0.551s)
[298.859550] Starting dynamic subtest: rcs0
[300.066707] Dynamic subtest rcs0: SUCCESS (1.218s)
[300.078864] Starting dynamic subtest: vcs1
[309.304678] Dynamic subtest vcs1: SUCCESS (9.235s)
[309.307374] Subtest timeout: SUCCESS (31.903s)
[309.377061] [018/132] (714s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[309.474695] Starting subtest: plane-upscale-factor-0-25-with-rotation
[309.476908] Starting dynamic subtest: pipe-A
[309.699887] Dynamic subtest pipe-A: SUCCESS (0.227s)
[309.710178] Starting dynamic subtest: pipe-B
[310.960100] Dynamic subtest pipe-B: SUCCESS (1.260s)
[310.970645] Starting dynamic subtest: pipe-C
[312.290126] Dynamic subtest pipe-C: SUCCESS (1.330s)
[312.300559] Starting dynamic subtest: pipe-D
[313.620180] Dynamic subtest pipe-D: SUCCESS (1.330s)
[313.622539] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.148s)
[314.804340] [019/132] (709s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[314.862704] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[314.867493] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[315.043783] [020/132] (708s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[315.148489] Starting subtest: x-tiled-32bpp-rotate-0
[316.730589] Subtest x-tiled-32bpp-rotate-0: FAIL (1.014s)
[316.767646] [021/132] (707s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[316.864658] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[316.866654] Starting dynamic subtest: pipe-A-eDP-1
[316.887021] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[316.898122] Starting dynamic subtest: pipe-B-eDP-1
[316.916106] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[316.924944] Starting dynamic subtest: pipe-C-eDP-1
[316.942858] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[316.951546] Starting dynamic subtest: pipe-D-eDP-1
[316.969903] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[316.974248] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.003s)
[319.154328] [022/132] (704s left) kms_flip (flip-vs-suspend)
[319.244881] Starting subtest: flip-vs-suspend
[319.247489] Starting dynamic subtest: A-eDP1
[464.143489] Dynamic subtest A-eDP1: SUCCESS (11.582s)
[464.146182] Subtest flip-vs-suspend: SUCCESS (11.584s)
[464.292018] [023/132] (559s left) kms_joiner (basic-force-ultra-joiner)
[464.403988] Starting subtest: basic-force-ultra-joiner
[464.409297] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[464.481585] [024/132] (559s left) syncobj_wait (invalid-single-wait-unsubmitted)
[464.539111] Starting subtest: invalid-single-wait-unsubmitted
[464.541134] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[464.653167] [025/132] (559s left) kms_lease (cursor-implicit-plane)
[464.740544] Starting subtest: cursor-implicit-plane
[464.743111] Starting dynamic subtest: pipe-A-eDP-1
[465.221761] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.469s)
[465.234965] Starting dynamic subtest: pipe-B-eDP-1
[466.360457] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.117s)
[466.372829] Starting dynamic subtest: pipe-C-eDP-1
[467.494387] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s)
[467.505947] Starting dynamic subtest: pipe-D-eDP-1
[468.639325] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[468.642246] Subtest cursor-implicit-plane: SUCCESS (3.830s)
[469.504186] [026/132] (554s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[469.611547] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[469.617182] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[469.704822] [027/132] (554s left) gem_ctx_persistence (engines-hostile-preempt)
[469.763862] Starting subtest: engines-hostile-preempt
[469.766310] Starting dynamic subtest: rcs0
[469.851645] Dynamic subtest rcs0: SUCCESS (0.086s)
[469.864911] Starting dynamic subtest: bcs0
[469.921825] Dynamic subtest bcs0: SUCCESS (0.068s)
[469.934410] Starting dynamic subtest: vcs0
[471.510085] Dynamic subtest vcs0: SUCCESS (1.571s)
[471.523141] Starting dynamic subtest: vcs1
[473.486770] Dynamic subtest vcs1: SUCCESS (1.958s)
[473.499347] Starting dynamic subtest: vecs0
[475.477842] Dynamic subtest vecs0: SUCCESS (1.976s)
[475.491085] Starting dynamic subtest: ccs0
[475.510406] Dynamic subtest ccs0: SUCCESS (0.032s)
[475.513164] Subtest engines-hostile-preempt: SUCCESS (5.700s)
[475.656315] [028/132] (548s left) perf_pmu (render-node-busy)
[475.724399] Starting subtest: render-node-busy
[475.727338] Starting dynamic subtest: rcs0
[476.310946] Dynamic subtest rcs0: SUCCESS (0.587s)
[476.323421] Starting dynamic subtest: bcs0
[476.873880] Dynamic subtest bcs0: SUCCESS (0.558s)
[476.886758] Starting dynamic subtest: vcs0
[478.492316] Dynamic subtest vcs0: SUCCESS (1.608s)
[478.505320] Starting dynamic subtest: vcs1
[480.540269] Dynamic subtest vcs1: SUCCESS (2.038s)
[480.553816] Starting dynamic subtest: vecs0
[482.524395] Dynamic subtest vecs0: SUCCESS (1.977s)
[482.537455] Starting dynamic subtest: ccs0
[483.095149] Dynamic subtest ccs0: SUCCESS (0.569s)
[483.098120] Subtest render-node-busy: SUCCESS (7.349s)
[483.171018] [029/132] (541s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[483.266386] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[483.272019] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[483.340698] [030/132] (541s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[483.394560] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[483.495214] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[483.584816] [031/132] (540s left) gem_mmap_gtt (cpuset-big-copy-odd)
[483.644902] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[483.700687] [032/132] (540s left) gem_sync (basic-store-each)
[483.778016] Starting subtest: basic-store-each
[486.440733] Subtest basic-store-each: SUCCESS (2.672s)
[486.632735] [033/132] (537s left) gem_mmap_wc (coherency)
[486.704389] Subtest coherency: SKIP (0.000s)
[486.769400] [034/132] (537s left) kms_big_fb (x-tiled-addfb-size-overflow)
[486.878080] Starting subtest: x-tiled-addfb-size-overflow
[486.880845] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[486.974606] [035/132] (537s left) gem_userptr_blits (unsync-unmap)
[487.044987] Subtest unsync-unmap: SKIP (0.000s)
[487.147808] [036/132] (537s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[487.272301] Starting subtest: basic-busy-flip-before-cursor-atomic
[487.277891] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[487.418967] [037/132] (537s left) syncobj_timeline (single-wait-all-available-submitted)
[487.472213] Starting subtest: single-wait-all-available-submitted
[487.474710] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[487.565841] [038/132] (537s left) gem_exec_schedule (pi-ringfull)
[487.750037] Starting subtest: pi-ringfull
[487.752769] Starting dynamic subtest: rcs0
[487.825978] Dynamic subtest rcs0: SUCCESS (0.080s)
[487.841402] Starting dynamic subtest: bcs0
[487.854234] Dynamic subtest bcs0: SUCCESS (0.028s)
[487.870482] Starting dynamic subtest: vcs0
[487.884117] Dynamic subtest vcs0: SUCCESS (0.028s)
[487.900446] Starting dynamic subtest: vcs1
[487.910290] Dynamic subtest vcs1: SUCCESS (0.026s)
[487.925851] Starting dynamic subtest: vecs0
[487.937050] Dynamic subtest vecs0: SUCCESS (0.027s)
[487.952138] Starting dynamic subtest: ccs0
[487.964368] Dynamic subtest ccs0: SUCCESS (0.027s)
[487.967097] Subtest pi-ringfull: SUCCESS (0.219s)
[488.188429] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[488.192020] [039/132] (536s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[488.294524] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[495.689148] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.391s)
[495.813643] [040/132] (529s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[495.921108] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[495.926263] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[496.017301] [041/132] (528s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[496.114121] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[496.116722] Starting dynamic subtest: pipe-A-eDP-1
[496.880660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.759s)
[496.891220] Starting dynamic subtest: pipe-B-eDP-1
[498.659268] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.778s)
[498.670518] Starting dynamic subtest: pipe-C-eDP-1
[500.495418] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.836s)
[500.507005] Starting dynamic subtest: pipe-D-eDP-1
[502.337242] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.840s)
[502.339778] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.217s)
[503.476122] [042/132] (521s left) gem_exec_params (readonly)
[503.545431] Starting subtest: readonly
[503.548027] Subtest readonly: SUCCESS (0.002s)
[503.663630] [043/132] (521s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[503.768329] Starting subtest: y-tiled-16bpp-rotate-180
[503.773961] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[503.866894] [044/132] (521s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[503.970319] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[503.973172] Starting dynamic subtest: pipe-A
[503.990517] Dynamic subtest pipe-A: SKIP (0.017s)
[504.001730] Starting dynamic subtest: pipe-B
[504.022566] Dynamic subtest pipe-B: SKIP (0.031s)
[504.033184] Starting dynamic subtest: pipe-C
[504.054083] Dynamic subtest pipe-C: SKIP (0.032s)
[504.064733] Starting dynamic subtest: pipe-D
[504.089715] Dynamic subtest pipe-D: SKIP (0.034s)
[504.094315] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.117s)
[504.186511] [045/132] (520s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[504.309118] Starting subtest: short-flip-after-cursor-toggle
[505.227213] Subtest short-flip-after-cursor-toggle: SUCCESS (0.915s)
[506.111861] [046/132] (519s left) kms_feature_discovery (dp-mst)
[506.193612] Starting subtest: dp-mst
[506.198338] Subtest dp-mst: SKIP (0.000s)
[506.269445] [047/132] (518s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[506.361190] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[506.366579] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[506.462466] [048/132] (518s left) gem_exec_params (invalid-flag)
[506.521783] Starting subtest: invalid-flag
[506.524338] Subtest invalid-flag: SUCCESS (0.000s)
[506.616625] [049/132] (518s left) kms_pm_rpm (pm-tiling)
[508.652896] Starting subtest: pm-tiling
[508.658139] Subtest pm-tiling: SKIP (0.000s)
[509.032574] [050/132] (516s left) prime_vgem (busy)
[509.109412] Starting subtest: busy
[509.112241] Starting dynamic subtest: rcs0
[509.151810] Dynamic subtest rcs0: SUCCESS (0.042s)
[509.162202] Starting dynamic subtest: bcs0
[509.197144] Dynamic subtest bcs0: SUCCESS (0.045s)
[509.208613] Starting dynamic subtest: vcs0
[509.244943] Dynamic subtest vcs0: SUCCESS (0.047s)
[509.256174] Starting dynamic subtest: vcs1
[509.290620] Dynamic subtest vcs1: SUCCESS (0.045s)
[509.301974] Starting dynamic subtest: vecs0
[509.337417] Dynamic subtest vecs0: SUCCESS (0.046s)
[509.349094] Starting dynamic subtest: ccs0
[509.384951] Dynamic subtest ccs0: SUCCESS (0.047s)
[509.387260] Subtest busy: SUCCESS (0.276s)
[509.508314] [051/132] (515s left) gem_pxp (reject-modify-context-protection-on)
[509.620912] Starting subtest: reject-modify-context-protection-on
[509.624224] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[509.734268] [052/132] (515s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[509.796385] Subtest tiled-to-untiled: SKIP (0.000s)
[509.863243] [053/132] (515s left) kms_flip (nonblocking-read)
[509.948630] Starting subtest: nonblocking-read
[509.951019] Subtest nonblocking-read: SUCCESS (0.000s)
[510.053345] [054/132] (515s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[510.102250] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[510.208660] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[510.291873] [055/132] (515s left) gem_lmem_evict (dontneed-evict-race)
[510.338841] Subtest dontneed-evict-race: SKIP (0.000s)
[510.386732] [056/132] (515s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[510.480181] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[510.485041] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[510.583731] [057/132] (515s left) gem_exec_fence (syncobj-import)
[510.994802] Starting subtest: syncobj-import
[511.000442] Subtest syncobj-import: SUCCESS (0.005s)
[512.611526] [058/132] (513s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[512.704939] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[512.707907] Starting dynamic subtest: pipe-A-eDP-1
[512.734292] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[512.746409] Starting dynamic subtest: pipe-B-eDP-1
[512.773132] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[512.784209] Starting dynamic subtest: pipe-C-eDP-1
[512.810111] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[512.820861] Starting dynamic subtest: pipe-D-eDP-1
[512.848243] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[512.853422] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[514.984865] [059/132] (510s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[515.367621] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[516.185789] [060/132] (509s left) kms_chamelium_frames (dp-crc-single)
[516.566957] Subtest dp-crc-single: SKIP (0.000s)
[517.413706] [061/132] (508s left) gem_partial_pwrite_pread (write-uncached)
[517.472591] Subtest write-uncached: SKIP (0.000s)
[517.544014] [062/132] (508s left) gen9_exec_parse (basic-rejected-ctx-param)
[517.596015] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[517.656790] [063/132] (508s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[517.760683] Starting subtest: fbc-tiling-linear
[521.479627] Subtest fbc-tiling-linear: SUCCESS (3.723s)
[522.624902] [064/132] (503s left) kms_cursor_crc (cursor-onscreen-256x85)
[522.883484] Starting subtest: cursor-onscreen-256x85
[522.937944] Subtest cursor-onscreen-256x85: SKIP (0.050s)
[523.090398] [065/132] (502s left) prime_self_import (reimport-vs-gem_close-race)
[523.129948] Starting subtest: reimport-vs-gem_close-race
[528.206432] Subtest reimport-vs-gem_close-race: SUCCESS (5.078s)
[528.286024] [066/132] (497s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[528.397568] Starting subtest: 4-tiled-addfb-size-offset-overflow
[528.400258] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[528.501897] [067/132] (497s left) api_intel_bb (offset-control)
[528.560142] Starting subtest: offset-control
[528.565313] Subtest offset-control: SUCCESS (0.008s)
[528.690423] [068/132] (497s left) gem_exec_params (no-vebox)
[528.744949] Starting subtest: no-vebox
[528.747438] Subtest no-vebox: SUCCESS (0.004s)
[530.595445] [069/132] (495s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[530.688920] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[535.302813] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.616s)
[536.424922] [070/132] (489s left) kms_content_protection (type1)
[536.564968] Starting subtest: type1
[536.570334] Subtest type1: SKIP (0.000s)
[536.696931] [071/132] (489s left) gem_exec_params (batch-first)
[536.748760] Starting subtest: batch-first
[536.755919] Subtest batch-first: SUCCESS (0.007s)
[536.866268] [072/132] (489s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[536.961122] Starting subtest: psr2-overlay-plane-move-continuous-sf
[536.963719] Starting dynamic subtest: pipe-A-eDP-1
[542.970793] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.011s)
[542.982705] Starting dynamic subtest: pipe-B-eDP-1
[549.716191] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.745s)
[549.718922] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.759s)
[550.582873] [073/132] (475s left) gem_ctx_shared (q-independent)
[550.650659] Starting subtest: Q-independent
[550.652960] Starting dynamic subtest: rcs0
[550.720953] Dynamic subtest rcs0: SUCCESS (0.070s)
[550.734829] Starting dynamic subtest: vcs0
[550.760755] Dynamic subtest vcs0: SUCCESS (0.039s)
[550.772007] Starting dynamic subtest: vcs1
[550.801339] Dynamic subtest vcs1: SUCCESS (0.039s)
[550.813386] Starting dynamic subtest: vecs0
[550.838992] Dynamic subtest vecs0: SUCCESS (0.036s)
[550.853394] Starting dynamic subtest: ccs0
[550.880988] Dynamic subtest ccs0: SUCCESS (0.042s)
[550.883673] Subtest Q-independent: SUCCESS (0.230s)
[552.574496] [074/132] (473s left) i915_query (query-topology-known-pci-ids)
[552.624256] Starting subtest: query-topology-known-pci-ids
[552.629215] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[552.723664] [075/132] (473s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[552.814878] Starting subtest: psr-rgb565-draw-mmap-wc
[559.624724] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.811s)
[559.749651] [076/132] (466s left) gem_userptr_blits (set-cache-level)
[559.821538] Starting subtest: set-cache-level
[559.826376] Subtest set-cache-level: SKIP (0.000s)
[559.942445] [077/132] (466s left) gem_readwrite (write-bad-handle)
[559.996938] Subtest write-bad-handle: SKIP (0.000s)
[560.056389] [078/132] (466s left) gem_ctx_persistence (legacy-engines-hang)
[560.109234] Starting subtest: legacy-engines-hang
[560.112232] Starting dynamic subtest: render
[560.230419] Dynamic subtest render: SUCCESS (0.120s)
[560.247705] Starting dynamic subtest: bsd1
[560.330200] Dynamic subtest bsd1: SUCCESS (0.094s)
[560.346191] Starting dynamic subtest: bsd2
[560.428871] Dynamic subtest bsd2: SUCCESS (0.096s)
[560.446563] Starting dynamic subtest: blt
[560.522739] Dynamic subtest blt: SUCCESS (0.091s)
[560.535430] Starting dynamic subtest: vebox
[560.627644] Dynamic subtest vebox: SUCCESS (0.102s)
[560.630334] Subtest legacy-engines-hang: SUCCESS (0.520s)
[560.709808] [079/132] (465s left) gem_softpin (evict-active)
[560.774256] Starting subtest: evict-active
[560.779718] Subtest evict-active: SUCCESS (0.005s)
[560.868211] [080/132] (465s left) gen9_exec_parse (unaligned-access)
[560.931128] Subtest unaligned-access: SKIP (0.000s)
[560.997789] [081/132] (465s left) i915_query (engine-info-invalid)
[561.051113] Starting subtest: engine-info-invalid
[561.053070] Subtest engine-info-invalid: SUCCESS (0.000s)
[561.157875] [082/132] (465s left) kms_color (ctm-blue-to-red)
[561.243902] Starting subtest: ctm-blue-to-red
[561.246127] Starting dynamic subtest: pipe-A-eDP-1
[561.955058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[561.966516] Starting dynamic subtest: pipe-B-eDP-1
[563.345643] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s)
[563.357183] Starting dynamic subtest: pipe-C-eDP-1
[564.697312] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.350s)
[564.708729] Starting dynamic subtest: pipe-D-eDP-1
[566.052280] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.357s)
[566.055257] Subtest ctm-blue-to-red: SUCCESS (4.811s)
[566.873198] [083/132] (459s left) kms_psr (psr-sprite-render)
[566.965159] Starting subtest: psr-sprite-render
[566.967983] Starting dynamic subtest: eDP-1
[568.699941] Dynamic subtest eDP-1: SUCCESS (1.737s)
[568.702520] Subtest psr-sprite-render: SUCCESS (1.738s)
[569.528204] [084/132] (457s left) perf (invalid-open-flags)
[569.676753] Starting subtest: invalid-open-flags
[569.679247] Subtest invalid-open-flags: SUCCESS (0.000s)
[569.721963] [085/132] (457s left) dumb_buffer (map-valid)
[569.778236] Starting subtest: map-valid
[569.781301] Subtest map-valid: SUCCESS (0.000s)
[569.877643] [086/132] (457s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[569.974280] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[569.978906] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[570.072962] [087/132] (456s left) kms_pm_dc (dc9-dpms)
[571.169794] Starting subtest: dc9-dpms
[572.596397] Subtest dc9-dpms: SUCCESS (1.425s)
[572.666857] [088/132] (454s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[572.767113] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[580.068304] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.304s)
[580.197103] [089/132] (446s left) gem_exec_params (secure-non-root)
[580.258413] Starting subtest: secure-non-root
[580.264235] Subtest secure-non-root: SKIP (0.000s)
[580.356965] [090/132] (446s left) kms_plane_alpha_blend (alpha-opaque-fb)
[580.447329] Starting subtest: alpha-opaque-fb
[580.732640] Starting dynamic subtest: pipe-A-eDP-1
[581.408057] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.675s)
[581.420055] Starting dynamic subtest: pipe-D-eDP-1
[582.840864] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.428s)
[582.843659] Subtest alpha-opaque-fb: SUCCESS (2.395s)
[583.728804] [091/132] (443s left) kms_psr (pr-primary-render)
[583.828995] Starting subtest: pr-primary-render
[583.834191] Subtest pr-primary-render: SKIP (0.000s)
[583.903741] [092/132] (443s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[584.027234] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[593.529468] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.503s)
[594.346941] [093/132] (432s left) api_intel_bb (blit-noreloc-keep-cache)
[594.416625] Starting subtest: blit-noreloc-keep-cache
[594.423012] Subtest blit-noreloc-keep-cache: SUCCESS (0.009s)
[594.552919] [094/132] (432s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[594.650152] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[604.311244] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.663s)
[604.442489] [095/132] (422s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[604.547015] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[604.551436] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[604.615243] [096/132] (422s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[604.715445] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[608.647305] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.936s)
[609.772144] [097/132] (417s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[609.956320] Starting subtest: cursor-rapid-movement-64x64
[609.958885] Starting dynamic subtest: pipe-A-eDP-1
[610.529347] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[610.558927] Starting dynamic subtest: pipe-D-eDP-1
[611.803389] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.250s)
[611.806020] Subtest cursor-rapid-movement-64x64: SUCCESS (1.846s)
[612.638985] [098/132] (414s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[612.729338] Starting subtest: plane-all-transition-nonblocking-fencing
[612.732127] Starting dynamic subtest: pipe-A-eDP-1
[615.227073] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[615.538554] Starting dynamic subtest: pipe-B-eDP-1
[618.769318] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.242s)
[619.067293] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.338s)
[619.886519] [099/132] (407s left) kms_properties (plane-properties-atomic)
[619.984001] Starting subtest: plane-properties-atomic
[619.986509] Starting dynamic subtest: pipe-A-eDP-1
[620.529418] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[620.541255] Starting dynamic subtest: pipe-B-eDP-1
[621.871453] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.337s)
[621.885897] Starting dynamic subtest: pipe-C-eDP-1
[623.108152] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.233s)
[623.119850] Starting dynamic subtest: pipe-D-eDP-1
[624.341228] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[624.344023] Subtest plane-properties-atomic: SUCCESS (4.357s)
[625.146591] [100/132] (402s left) gem_exec_parallel (fds)
[625.208917] Starting subtest: fds
[625.211440] Starting dynamic subtest: rcs0
[628.152380] Dynamic subtest rcs0: SUCCESS (2.941s)
[628.165616] Starting dynamic subtest: bcs0
[632.885459] Dynamic subtest bcs0: SUCCESS (4.731s)
[632.897025] Starting dynamic subtest: vcs0
[638.506258] Dynamic subtest vcs0: SUCCESS (5.617s)
[638.520938] Starting dynamic subtest: vcs1
[642.764569] Dynamic subtest vcs1: SUCCESS (4.257s)
[642.778432] Starting dynamic subtest: vecs0
[648.483120] Dynamic subtest vecs0: SUCCESS (5.716s)
[648.495401] Starting dynamic subtest: ccs0
[653.427410] Dynamic subtest ccs0: SUCCESS (4.941s)
[653.430407] Subtest fds: SUCCESS (28.213s)
[653.628792] [101/132] (373s left) gem_mmap_gtt (hang-user)
[653.681289] Subtest hang-user: SKIP (0.000s)
[653.742783] [102/132] (373s left) kms_psr (psr2-cursor-render)
[653.839021] Starting subtest: psr2-cursor-render
[653.841411] Starting dynamic subtest: eDP-1
[655.531417] Dynamic subtest eDP-1: SUCCESS (1.692s)
[655.534437] Subtest psr2-cursor-render: SUCCESS (1.693s)
[656.428148] [103/132] (371s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[656.523156] Starting subtest: fbcpsr-rgb565-draw-blt
[663.693085] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.172s)
[663.842861] [104/132] (363s left) i915_pm_rps (engine-order)
[663.903052] Starting subtest: engine-order
[668.973231] Subtest engine-order: SUCCESS (5.067s)
[669.100685] [105/132] (358s left) syncobj_basic (bad-pad-fd-to-handle)
[669.158263] Starting subtest: bad-pad-fd-to-handle
[669.161192] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[669.259810] [106/132] (358s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[669.356190] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[669.361211] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[669.469496] [107/132] (358s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[669.528744] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[669.532050] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[669.634341] [108/132] (358s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[669.723974] Starting subtest: fbcpsr-1p-rte
[676.807309] Subtest fbcpsr-1p-rte: SUCCESS (7.086s)
[676.946740] [109/132] (351s left) vgem_basic (create)
[676.995282] Starting subtest: create
[676.997618] Subtest create: SUCCESS (0.000s)
[677.054111] [110/132] (350s left) syncobj_wait (invalid-signal-zero-handles)
[677.114415] Starting subtest: invalid-signal-zero-handles
[677.117146] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[677.237726] [111/132] (350s left) kms_plane_lowres (tiling-y)
[677.333320] Starting subtest: tiling-y
[677.338954] Subtest tiling-y: SKIP (0.000s)
[677.407068] [112/132] (350s left) kms_big_fb (yf-tiled-addfb)
[677.505680] Starting subtest: yf-tiled-addfb
[677.510950] Subtest yf-tiled-addfb: SKIP (0.000s)
[677.617742] [113/132] (350s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[677.673628] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[677.676160] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[677.775060] [114/132] (350s left) kms_cursor_edge_walk (128x128-top-edge)
[677.864088] Starting subtest: 128x128-top-edge
[677.866104] Starting dynamic subtest: pipe-A-eDP-1
[681.358258] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.491s)
[681.371071] Starting dynamic subtest: pipe-D-eDP-1
[684.485238] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[684.487867] Subtest 128x128-top-edge: SUCCESS (6.618s)
[685.286842] [115/132] (342s left) gem_softpin (noreloc-interruptible)
[685.358304] Starting subtest: noreloc-interruptible
[690.747407] Subtest noreloc-interruptible: SUCCESS (5.391s)
[690.871927] [116/132] (337s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[690.924224] Subtest writes-after-reads-uncached: SKIP (0.000s)
[690.999683] [117/132] (337s left) dmabuf_sync_file (import-multiple-read-only)
[691.036828] Starting subtest: import-multiple-read-only
[691.039424] Subtest import-multiple-read-only: SUCCESS (0.003s)
[691.095315] [118/132] (337s left) kms_addfb_basic (unused-offsets)
[691.154700] Starting subtest: unused-offsets
[691.157046] Subtest unused-offsets: SUCCESS (0.000s)
[691.293005] [119/132] (337s left) kms_psr (fbc-psr-primary-mmap-gtt)
[691.378199] Starting subtest: fbc-psr-primary-mmap-gtt
[691.380944] Starting dynamic subtest: eDP-1
[691.385812] Dynamic subtest eDP-1: SKIP (0.000s)
[691.390277] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[691.462998] [120/132] (337s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[691.552225] Starting subtest: fbc-pr-sprite-mmap-cpu
[691.557429] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[691.630018] [121/132] (336s left) gem_exec_balancer (nohangcheck)
[691.889375] Starting subtest: nohangcheck
[692.846118] Subtest nohangcheck: SUCCESS (0.956s)
[692.960552] [122/132] (335s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[693.050684] Starting subtest: primary-y-tiled-reflect-x-90
[693.055423] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[693.129253] [123/132] (335s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[693.225430] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[693.230854] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[693.327769] [124/132] (335s left) kms_universal_plane (universal-plane-sanity)
[693.418061] Starting subtest: universal-plane-sanity
[693.420033] Starting dynamic subtest: pipe-A-eDP-1
[694.007437] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[694.022431] Starting dynamic subtest: pipe-B-eDP-1
[695.213610] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.205s)
[695.226114] Starting dynamic subtest: pipe-C-eDP-1
[696.429128] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.214s)
[696.441866] Starting dynamic subtest: pipe-D-eDP-1
[697.638228] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s)
[697.640991] Subtest universal-plane-sanity: SUCCESS (4.223s)
[698.507782] [125/132] (330s left) gem_exec_schedule (submit-late-slice)
[698.575386] Starting subtest: submit-late-slice
[698.578167] Starting dynamic subtest: rcs0
[698.602774] Dynamic subtest rcs0: SUCCESS (0.038s)
[698.614426] Starting dynamic subtest: bcs0
[698.632789] Dynamic subtest bcs0: SUCCESS (0.029s)
[698.644234] Starting dynamic subtest: vcs0
[698.666777] Dynamic subtest vcs0: SUCCESS (0.033s)
[698.685397] Starting dynamic subtest: vcs1
[698.698163] Dynamic subtest vcs1: SUCCESS (0.029s)
[698.710281] Starting dynamic subtest: vecs0
[698.729861] Dynamic subtest vecs0: SUCCESS (0.030s)
[698.741906] Starting dynamic subtest: ccs0
[698.761437] Dynamic subtest ccs0: SUCCESS (0.031s)
[698.764229] Subtest submit-late-slice: SUCCESS (0.197s)
[700.614773] [126/132] (328s left) gem_exec_whisper (basic-fds)
[700.674096] Starting subtest: basic-fds
[708.413399] Subtest basic-fds: SUCCESS (7.736s)
[708.602407] [127/132] (320s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[708.721252] Starting subtest: flip-vs-cursor-toggle
[717.749295] Subtest flip-vs-cursor-toggle: SUCCESS (9.027s)
[718.546005] [128/132] (310s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[718.647199] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[718.650107] Starting dynamic subtest: pipe-A-default-mode
[719.808971] Dynamic subtest pipe-A-default-mode: SKIP (1.158s)
[719.814085] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.160s)
[719.958927] [129/132] (308s left) i915_hangman (engine-error-state-capture)
[720.031642] Starting subtest: engine-error-state-capture
[720.033995] Starting dynamic subtest: rcs0
[723.449802] Dynamic subtest rcs0: SUCCESS (3.418s)
[723.463577] Starting dynamic subtest: bcs0
[729.466268] Dynamic subtest bcs0: SUCCESS (6.013s)
[729.481203] Starting dynamic subtest: vcs0
[735.418667] Dynamic subtest vcs0: SUCCESS (5.949s)
[735.433222] Starting dynamic subtest: vcs1
[740.412808] Dynamic subtest vcs1: SUCCESS (4.990s)
[740.428398] Starting dynamic subtest: vecs0
[746.426594] Dynamic subtest vecs0: SUCCESS (6.012s)
[746.441881] Starting dynamic subtest: ccs0
[752.442723] Dynamic subtest ccs0: SUCCESS (6.012s)
[752.445595] Subtest engine-error-state-capture: SUCCESS (32.413s)
[752.583782] [130/132] (276s left) kms_async_flips (alternate-sync-async-flip)
[752.673847] Starting subtest: alternate-sync-async-flip
[753.046701] Starting dynamic subtest: pipe-A-eDP-1
[755.868638] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.824s)
[756.268405] Starting dynamic subtest: pipe-B-eDP-1
[759.007206] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.752s)
[759.393130] Starting dynamic subtest: pipe-C-eDP-1
[762.145607] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s)
[762.516340] Starting dynamic subtest: pipe-D-eDP-1
[765.270200] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[765.272908] Subtest alternate-sync-async-flip: SUCCESS (12.599s)
[766.441520] [131/132] (262s left) kms_vblank (ts-continuation-idle)
[766.545181] Starting subtest: ts-continuation-idle
[766.547773] Starting dynamic subtest: pipe-A-eDP-1
[766.942422] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[766.959055] Starting dynamic subtest: pipe-D-eDP-1
[768.031171] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.086s)
[768.033931] Subtest ts-continuation-idle: SUCCESS (1.488s)
[768.908951] [132/132] (260s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[768.995215] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[768.997931] Starting dynamic subtest: pipe-A-eDP-1
[769.008163] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[769.021120] Starting dynamic subtest: pipe-B-eDP-1
[769.031720] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[769.043232] Starting dynamic subtest: pipe-C-eDP-1
[769.053169] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[769.064391] Starting dynamic subtest: pipe-D-eDP-1
[769.074261] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[769.079189] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[771.265201] Closing watchdogs
results: parsing output: 0/ for test: kms_atomic
results: parsing output: 1/ for test: gem_reg_read
results: parsing output: 2/ for test: gem_softpin
results: parsing output: 3/ for test: gem_ctx_engines
results: parsing output: 4/ for test: gem_exec_capture
results: parsing output: 5/ for test: kms_debugfs
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_ppgtt
results: parsing output: 16/ for test: sysfs_timeslice_duration
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: gem_render_copy
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_joiner
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_lease
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: gem_sync
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: gem_userptr_blits
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: kms_big_fb
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_feature_discovery
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: prime_vgem
results: parsing output: 50/ for test: gem_pxp
results: parsing output: 51/ for test: gem_set_tiling_vs_blt
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_lmem_evict
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: kms_chamelium_hpd
results: parsing output: 59/ for test: kms_chamelium_frames
results: parsing output: 60/ for test: gem_partial_pwrite_pread
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: prime_self_import
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: api_intel_bb
results: parsing output: 67/ for test: gem_exec_params
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_content_protection
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: gem_ctx_shared
results: parsing output: 73/ for test: i915_query
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_userptr_blits
results: parsing output: 76/ for test: gem_readwrite
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: gem_softpin
results: parsing output: 79/ for test: gen9_exec_parse
results: parsing output: 80/ for test: i915_query
results: parsing output: 81/ for test: kms_color
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: dumb_buffer
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_pm_dc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: kms_plane_alpha_blend
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: api_intel_bb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: kms_atomic_transition
results: parsing output: 98/ for test: kms_properties
results: parsing output: 99/ for test: gem_exec_parallel
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: i915_pm_rps
results: parsing output: 104/ for test: syncobj_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: vgem_basic
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_plane_lowres
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_cursor_edge_walk
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: gem_partial_pwrite_pread
results: parsing output: 116/ for test: dmabuf_sync_file
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_universal_plane
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: gem_exec_whisper
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: i915_hangman
results: parsing output: 129/ for test: kms_async_flips
results: parsing output: 130/ for test: kms_vblank
results: parsing output: 131/ for test: kms_ccs
Done.