[57.515685] Initializing watchdogs [57.515729] /dev/watchdog0 [57.529897] [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.534446] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.537340] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.540656] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite) [57.657184] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite [62.593188] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.965s) [63.765754] [002/133] (954s left) syncobj_timeline (invalid-signal-zero-handles) [63.821314] Starting subtest: invalid-signal-zero-handles [63.823694] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [63.918884] [003/133] (954s left) syncobj_basic (bad-create-flags) [63.961745] Starting subtest: bad-create-flags [63.963988] Subtest bad-create-flags: SUCCESS (0.000s) [64.050814] [004/133] (954s left) gem_exec_alignment (pi) [64.108041] Starting subtest: pi [115.041350] Subtest pi: SUCCESS (50.945s) [115.902466] [005/133] (902s left) kms_psr (fbc-psr-sprite-mmap-gtt) [116.048931] Starting subtest: fbc-psr-sprite-mmap-gtt [116.051302] Starting dynamic subtest: eDP-1 [116.055519] Dynamic subtest eDP-1: SKIP (0.000s) [116.059753] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s) [116.121662] [006/133] (902s left) kms_cursor_crc (cursor-rapid-movement-512x170) [116.423712] Starting subtest: cursor-rapid-movement-512x170 [116.427804] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [116.572428] [007/133] (901s left) api_intel_allocator (gem-pool) [116.635632] Starting subtest: gem-pool [116.642989] Subtest gem-pool: SUCCESS (0.008s) [116.769427] [008/133] (901s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [116.852499] Starting subtest: primary-y-tiled-reflect-x-90 [116.856045] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [116.945969] [009/133] (901s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [117.050382] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [117.054079] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [117.164202] [010/133] (901s left) syncobj_timeline (etime-single-wait-submitted) [117.218352] Starting subtest: etime-single-wait-submitted [117.323570] Subtest etime-single-wait-submitted: SUCCESS (0.102s) [117.405878] [011/133] (901s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [117.528644] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [117.533060] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [117.592397] [012/133] (900s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [117.698902] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [117.703322] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [117.785800] [013/133] (900s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [117.838830] Subtest no-spare-fences-interruptible: SKIP (0.000s) [117.899134] [014/133] (900s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [117.986360] Starting subtest: bad-aux-stride-y-tiled-ccs [117.988606] Starting dynamic subtest: pipe-A-eDP-1 [118.011073] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [118.025821] Starting dynamic subtest: pipe-B-eDP-1 [118.049856] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [118.065502] Starting dynamic subtest: pipe-C-eDP-1 [118.087903] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [118.103722] Starting dynamic subtest: pipe-D-eDP-1 [118.127213] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [118.131899] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.002s) [120.210522] [015/133] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [120.318733] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [127.649062] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.331s) [127.771106] [016/133] (890s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [127.877176] Starting subtest: psr-modesetfrombusy [133.996691] Subtest psr-modesetfrombusy: SUCCESS (6.124s) [134.121553] [017/133] (884s left) gem_mmap_gtt (basic-read) [134.178049] Subtest basic-read: SKIP (0.000s) [134.230253] [018/133] (884s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [134.319880] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [138.763203] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.446s) [139.899190] [019/133] (878s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [139.998077] Starting subtest: planes-downscale-factor-0-75-unity-scaling [140.000448] Starting dynamic subtest: pipe-A [140.060843] Dynamic subtest pipe-A: SUCCESS (0.065s) [140.071443] Starting dynamic subtest: pipe-B [141.205783] Dynamic subtest pipe-B: SUCCESS (1.145s) [141.216477] Starting dynamic subtest: pipe-C [142.307149] Dynamic subtest pipe-C: SUCCESS (1.100s) [142.316643] Starting dynamic subtest: pipe-D [143.450464] Dynamic subtest pipe-D: SUCCESS (1.143s) [143.452871] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.455s) [144.611204] [020/133] (874s left) gem_ctx_persistence (legacy-engines-queued) [144.678614] Starting subtest: legacy-engines-queued [144.681040] Starting dynamic subtest: render [144.761643] Dynamic subtest render: SUCCESS (0.082s) [144.771757] Starting dynamic subtest: bsd1 [145.845500] Dynamic subtest bsd1: SUCCESS (1.080s) [145.854697] Starting dynamic subtest: bsd2 [147.892448] Dynamic subtest bsd2: SUCCESS (2.044s) [147.902813] Starting dynamic subtest: blt [147.964970] Dynamic subtest blt: SUCCESS (0.072s) [147.975507] Starting dynamic subtest: vebox [149.876945] Dynamic subtest vebox: SUCCESS (1.907s) [149.880157] Subtest legacy-engines-queued: SUCCESS (5.195s) [150.003778] [021/133] (868s left) kms_chamelium_hpd (common-hpd-after-suspend) [150.395569] Subtest common-hpd-after-suspend: SKIP (0.000s) [151.214675] [022/133] (867s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [151.312642] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [155.968749] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.661s) [157.134199] [023/133] (861s left) kms_vblank (query-forked-hang) [157.223412] Starting subtest: query-forked-hang [157.225925] Starting dynamic subtest: pipe-A-eDP-1 [183.636083] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.408s) [183.650148] Starting dynamic subtest: pipe-D-eDP-1 [208.658760] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.019s) [208.661037] Subtest query-forked-hang: SUCCESS (51.431s) [209.471667] [024/133] (809s left) gem_mmap_gtt (zero-extend) [209.529469] Subtest zero-extend: SKIP (0.000s) [209.590058] [025/133] (809s left) gem_exec_whisper (basic-fds) [209.646586] Starting subtest: basic-fds [216.886665] Subtest basic-fds: SUCCESS (7.236s) [217.067717] [026/133] (801s left) gem_exec_reloc (basic-cpu-active) [217.125505] Subtest basic-cpu-active: SKIP (0.000s) [217.202072] [027/133] (801s left) gem_workarounds (suspend-resume-fd) [217.264191] Starting subtest: suspend-resume-fd [233.634136] Subtest suspend-resume-fd: SUCCESS (1.458s) [234.780645] [028/133] (785s left) kms_cursor_legacy (single-move) [234.931553] Starting subtest: single-move [234.934072] Starting dynamic subtest: pipe-A [240.194356] Dynamic subtest pipe-A: SUCCESS (5.380s) [240.204914] Starting dynamic subtest: pipe-B [245.518676] Dynamic subtest pipe-B: SUCCESS (5.381s) [245.528681] Starting dynamic subtest: pipe-C [250.869859] Dynamic subtest pipe-C: SUCCESS (5.380s) [250.879559] Starting dynamic subtest: pipe-D [256.239057] Dynamic subtest pipe-D: SUCCESS (5.383s) [256.254375] Starting dynamic subtest: all-pipes [261.619230] Dynamic subtest all-pipes: SUCCESS (5.386s) [261.621743] Subtest single-move: SUCCESS (26.923s) [261.761343] [029/133] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [261.870628] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [268.945844] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.079s) [269.074246] [030/133] (751s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [269.177650] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [269.182445] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [269.264398] [031/133] (750s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [269.381646] Starting subtest: verify-pxp-execution-after-suspend-resume [276.416459] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.037s) [276.552319] [032/133] (743s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [276.648143] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [276.659840] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s) [276.740080] [033/133] (743s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [276.842313] Starting subtest: psr2-plane-move-sf-dmg-area [276.844550] Starting dynamic subtest: pipe-A-eDP-1 [281.388589] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.549s) [281.399067] Starting dynamic subtest: pipe-B-eDP-1 [286.681101] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.294s) [286.683424] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.846s) [287.551639] [034/133] (732s left) gem_eio (in-flight-10ms) [287.777791] Starting subtest: in-flight-10ms [296.837324] Subtest in-flight-10ms: SUCCESS (9.062s) [296.953077] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true [296.956265] [035/133] (723s left) kms_setmode (clone-exclusive-crtc) [297.017008] Starting subtest: clone-exclusive-crtc [297.023423] Subtest clone-exclusive-crtc: SKIP (0.000s) [297.111478] [036/133] (723s left) kms_cursor_edge_walk (256x256-top-edge) [297.202567] Starting subtest: 256x256-top-edge [297.204867] Starting dynamic subtest: pipe-A-eDP-1 [300.628705] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s) [300.648336] Starting dynamic subtest: pipe-D-eDP-1 [303.746413] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s) [303.748668] Subtest 256x256-top-edge: SUCCESS (6.546s) [304.563212] [037/133] (715s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [304.654359] Starting subtest: async-flip-with-page-flip-events-tiled [305.024237] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [307.834800] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.810s) [307.844697] Starting dynamic subtest: pipe-A-eDP-1-4 [310.008448] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s) [310.019833] Starting dynamic subtest: pipe-A-eDP-1-4 [312.017601] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [312.027482] Starting dynamic subtest: pipe-A-eDP-1-x [314.196119] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s) [314.567815] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [317.359871] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.800s) [317.370708] Starting dynamic subtest: pipe-B-eDP-1-4 [319.533945] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.173s) [319.546471] Starting dynamic subtest: pipe-B-eDP-1-4 [321.543392] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [321.555440] Starting dynamic subtest: pipe-B-eDP-1-x [323.744147] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.202s) [324.132497] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [326.888257] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.761s) [326.898515] Starting dynamic subtest: pipe-C-eDP-1-4 [329.082095] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.196s) [329.091815] Starting dynamic subtest: pipe-C-eDP-1-4 [331.091246] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [331.101831] Starting dynamic subtest: pipe-C-eDP-1-x [333.269845] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [333.630685] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [336.416413] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.794s) [336.429928] Starting dynamic subtest: pipe-D-eDP-1-4 [338.588522] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s) [338.598296] Starting dynamic subtest: pipe-D-eDP-1-4 [340.598727] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [340.611257] Starting dynamic subtest: pipe-D-eDP-1-x [342.776576] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [342.779413] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.135s) [344.015312] [038/133] (676s left) gem_exec_params (dr1-dirt) [344.076832] Starting subtest: DR1-dirt [344.079394] Subtest DR1-dirt: SUCCESS (0.000s) [344.188556] [039/133] (676s left) gem_lmem_swapping (massive-random) [344.233963] Subtest massive-random: SKIP (0.000s) [344.275497] [040/133] (676s left) kms_pm_rpm (modeset-lpsp-stress) [345.998624] Starting subtest: modeset-lpsp-stress [362.149015] Subtest modeset-lpsp-stress: SUCCESS (16.159s) [362.249527] [041/133] (658s left) gem_exec_fence (syncobj-export) [362.720151] Starting subtest: syncobj-export [362.726273] Subtest syncobj-export: SUCCESS (0.005s) [363.853885] [042/133] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [363.950749] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [363.955059] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [364.059810] [043/133] (656s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [364.149347] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [364.151647] Starting dynamic subtest: pipe-A-eDP-1 [380.678998] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.351s) [380.689495] Starting dynamic subtest: pipe-B-eDP-1 [397.655532] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.401s) [397.666699] Starting dynamic subtest: pipe-C-eDP-1 [414.634989] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.376s) [414.646527] Starting dynamic subtest: pipe-D-eDP-1 [431.649152] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.382s) [431.651553] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.516s) [432.843756] [044/133] (587s left) kms_mmap_write_crc (main) [432.947603] Starting subtest: main [432.949918] Starting dynamic subtest: pipe-A-eDP-1 [436.230602] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.344s) [436.233109] Subtest main: SUCCESS (3.346s) [437.127833] [045/133] (583s left) gem_exec_balancer (parallel-out-fence) [437.382237] Starting subtest: parallel-out-fence [438.486391] Subtest parallel-out-fence: SUCCESS (1.121s) [438.603087] [046/133] (582s left) gem_exec_gttfill (multigpu-basic) [438.779406] Starting subtest: multigpu-basic [451.099613] Subtest multigpu-basic: SUCCESS (12.394s) [451.149226] [047/133] (569s left) gem_flink_race (flink_name) [451.233516] Starting subtest: flink_name [456.613980] Subtest flink_name: SUCCESS (5.390s) [456.728243] [048/133] (564s left) gem_softpin (allocator-evict) [456.792690] Starting subtest: allocator-evict [456.795023] Starting dynamic subtest: rcs0 [480.667228] Dynamic subtest rcs0: SUCCESS (23.873s) [480.677254] Starting dynamic subtest: bcs0 [504.501389] Dynamic subtest bcs0: SUCCESS (23.836s) [504.514688] Starting dynamic subtest: vcs0 [528.302199] Dynamic subtest vcs0: SUCCESS (23.804s) [528.313056] Starting dynamic subtest: vcs1 [552.214635] Dynamic subtest vcs1: SUCCESS (23.904s) [552.232921] Starting dynamic subtest: vecs0 [575.779825] Dynamic subtest vecs0: SUCCESS (23.563s) [575.790565] Starting dynamic subtest: ccs0 [599.591378] Dynamic subtest ccs0: SUCCESS (23.813s) [599.594032] Subtest allocator-evict: SUCCESS (142.801s) [599.677004] [049/133] (421s left) gem_wait (write-busy) [599.776745] Starting subtest: write-busy [599.778924] Starting dynamic subtest: all-engines [600.389347] Dynamic subtest all-engines: SUCCESS (0.614s) [600.404119] Starting dynamic subtest: rcs0 [600.945621] Dynamic subtest rcs0: SUCCESS (0.555s) [600.962441] Starting dynamic subtest: bcs0 [601.496434] Dynamic subtest bcs0: SUCCESS (0.550s) [601.512800] Starting dynamic subtest: vcs0 [602.985107] Dynamic subtest vcs0: SUCCESS (1.487s) [603.002549] Starting dynamic subtest: vcs1 [604.969463] Dynamic subtest vcs1: SUCCESS (1.981s) [604.985703] Starting dynamic subtest: vecs0 [606.954792] Dynamic subtest vecs0: SUCCESS (1.983s) [606.972554] Starting dynamic subtest: ccs0 [607.504442] Dynamic subtest ccs0: SUCCESS (0.548s) [607.507032] Subtest write-busy: SUCCESS (7.732s) [607.703399] [050/133] (413s left) gem_exec_balancer (full) [607.770443] Starting subtest: full [612.882044] Subtest full: SUCCESS (5.113s) [613.211593] [051/133] (407s left) syncobj_wait (wait-any-complex) [613.301233] Starting subtest: wait-any-complex [613.365068] Subtest wait-any-complex: SUCCESS (0.063s) [613.445671] [052/133] (407s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [613.566474] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [613.568716] Starting dynamic subtest: pipe-A-eDP-1 [613.624531] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [613.633756] Starting dynamic subtest: pipe-B-eDP-1 [613.689674] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [613.699697] Starting dynamic subtest: pipe-C-eDP-1 [613.753788] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [613.763355] Starting dynamic subtest: pipe-D-eDP-1 [613.819175] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [613.823420] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s) [615.830189] [053/133] (405s left) kms_hdmi_inject (inject-4k) [616.186293] Starting subtest: inject-4k [616.502415] Subtest inject-4k: SUCCESS (0.318s) [617.086654] [054/133] (404s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [617.184006] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [618.185374] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.001s) [618.325077] [055/133] (402s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [618.435541] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [618.439760] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [618.532340] [056/133] (402s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [618.627852] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [618.631508] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [618.741824] [057/133] (402s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [618.825906] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [618.829336] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [618.935205] [058/133] (402s left) kms_joiner (basic-max-non-joiner) [619.024995] Starting subtest: basic-max-non-joiner [619.028681] Subtest basic-max-non-joiner: SKIP (0.000s) [619.095088] [059/133] (402s left) perf (non-system-wide-paranoid) [619.222515] Starting subtest: non-system-wide-paranoid [619.254462] Subtest non-system-wide-paranoid: SUCCESS (0.032s) [619.308282] [060/133] (402s left) prime_mmap (test_forked_cpu_write) [619.366156] Starting subtest: test_forked_cpu_write [619.368021] Starting dynamic subtest: test_forked_cpu_write-smem [619.373219] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s) [619.375300] Subtest test_forked_cpu_write: SUCCESS (0.010s) [619.516046] [061/133] (402s left) kms_async_flips (invalid-async-flip) [619.609935] Starting subtest: invalid-async-flip [619.985441] Starting dynamic subtest: pipe-A-eDP-1 [620.872281] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.887s) [621.245037] Starting dynamic subtest: pipe-B-eDP-1 [622.045017] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.809s) [622.418095] Starting dynamic subtest: pipe-C-eDP-1 [623.228971] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.825s) [623.588843] Starting dynamic subtest: pipe-D-eDP-1 [624.429214] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.848s) [624.431630] Subtest invalid-async-flip: SUCCESS (4.822s) [625.657109] [062/133] (395s left) perf (missing-sample-flags) [625.755775] Starting subtest: missing-sample-flags [625.758221] Subtest missing-sample-flags: SUCCESS (0.000s) [625.803601] [063/133] (395s left) kms_psr (fbc-psr2-cursor-plane-move) [625.905776] Starting subtest: fbc-psr2-cursor-plane-move [625.908021] Starting dynamic subtest: eDP-1 [625.912637] Dynamic subtest eDP-1: SKIP (0.000s) [625.917230] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s) [626.022112] [064/133] (395s left) kms_feature_discovery (dp-mst) [626.114477] Starting subtest: dp-mst [626.118963] Subtest dp-mst: SKIP (0.000s) [626.193819] [065/133] (395s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [626.283685] Starting subtest: plane-scaler-unity-scaling-with-modifiers [626.285964] Starting dynamic subtest: pipe-A [626.642486] Dynamic subtest pipe-A: SUCCESS (0.362s) [626.654844] Starting dynamic subtest: pipe-B [628.011785] Dynamic subtest pipe-B: SUCCESS (1.366s) [628.021624] Starting dynamic subtest: pipe-C [629.405012] Dynamic subtest pipe-C: SUCCESS (1.393s) [629.416816] Starting dynamic subtest: pipe-D [630.808777] Dynamic subtest pipe-D: SUCCESS (1.402s) [630.811081] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.529s) [631.950564] [066/133] (389s left) kms_universal_plane (universal-plane-functional) [632.049575] Starting subtest: universal-plane-functional [632.051508] Starting dynamic subtest: pipe-A-eDP-1 [635.913588] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.866s) [635.924569] Starting dynamic subtest: pipe-B-eDP-1 [640.428720] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.512s) [640.439414] Starting dynamic subtest: pipe-C-eDP-1 [644.685864] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.257s) [644.696859] Starting dynamic subtest: pipe-D-eDP-1 [648.999852] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.310s) [649.002135] Subtest universal-plane-functional: SUCCESS (16.953s) [649.832681] [067/133] (372s left) gem_set_tiling_vs_gtt [649.972711] [068/133] (371s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling) [650.064230] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling [650.068160] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s) [650.168655] [069/133] (371s left) gem_ctx_param (invalid-ctx-set) [650.236233] Starting subtest: invalid-ctx-set [650.238600] Subtest invalid-ctx-set: SUCCESS (0.001s) [650.322788] [070/133] (371s left) gem_fenced_exec_thrash (no-spare-fences-busy) [650.374335] Subtest no-spare-fences-busy: SKIP (0.000s) [650.439202] [071/133] (371s left) i915_pm_rpm (gem-evict-pwrite) [652.084194] Starting subtest: gem-evict-pwrite [652.089312] Subtest gem-evict-pwrite: SKIP (0.000s) [652.756807] [072/133] (369s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [652.813783] Starting subtest: y-tiled-ccs-to-y-tiled [652.818053] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [652.995516] [073/133] (369s left) syncobj_wait (wait-delayed-signal) [653.048513] Starting subtest: wait-delayed-signal [653.150459] Subtest wait-delayed-signal: SUCCESS (0.102s) [653.232355] [074/133] (368s left) syncobj_eventfd (timeline-wait-signaled) [653.287133] Starting subtest: timeline-wait-signaled [653.289406] Subtest timeline-wait-signaled: SUCCESS (0.000s) [653.385768] [075/133] (368s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [653.466066] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [653.468436] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s) [653.563556] [076/133] (368s left) kms_chamelium_color (ctm-red-to-blue) [653.657881] Subtest ctm-red-to-blue: SKIP (0.000s) [653.703621] [077/133] (368s left) kms_big_fb (4-tiled-64bpp-rotate-180) [653.794055] Starting subtest: 4-tiled-64bpp-rotate-180 [655.306163] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.512s) [655.474736] [078/133] (366s left) kms_hdr (bpc-switch) [655.573556] Starting subtest: bpc-switch [656.677655] Starting dynamic subtest: pipe-A-eDP-1 [660.080180] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.404s) [660.082901] Subtest bpc-switch: SUCCESS (4.508s) [660.219855] [079/133] (362s left) device_reset (unbind-reset-rebind) [660.268098] Starting subtest: unbind-reset-rebind [665.272553] Subtest unbind-reset-rebind: SUCCESS (4.997s) [665.318273] [080/133] (357s left) kms_pm_dc (dc6-dpms) [666.432405] Starting subtest: dc6-dpms [668.470577] Subtest dc6-dpms: SUCCESS (2.037s) [668.550828] [081/133] (353s left) kms_flip (dpms-off-confusion) [668.646601] Starting subtest: dpms-off-confusion [668.648822] Starting dynamic subtest: A-eDP1 [677.321804] Dynamic subtest A-eDP1: SUCCESS (8.675s) [677.333093] Starting dynamic subtest: B-eDP1 [685.949431] Dynamic subtest B-eDP1: SUCCESS (8.624s) [685.980081] Starting dynamic subtest: C-eDP1 [694.663528] Dynamic subtest C-eDP1: SUCCESS (8.709s) [694.675271] Starting dynamic subtest: D-eDP1 [703.298944] Dynamic subtest D-eDP1: SUCCESS (8.633s) [703.304890] Subtest dpms-off-confusion: SUCCESS (34.653s) [704.475311] [082/133] (318s left) kms_psr (psr2-no-drrs) [704.582270] Starting subtest: psr2-no-drrs [704.584392] Starting dynamic subtest: eDP-1 [706.248070] Dynamic subtest eDP-1: SUCCESS (1.665s) [706.250462] Subtest psr2-no-drrs: SUCCESS (1.666s) [707.041231] [083/133] (315s left) gem_exec_create (madvise) [707.125956] Starting subtest: madvise [707.128436] Starting dynamic subtest: smem [727.286114] Dynamic subtest smem: SUCCESS (20.157s) [727.288501] Subtest madvise: SUCCESS (20.158s) [728.332689] [084/133] (294s left) api_intel_bb (simple-bb-ctx) [728.389881] Starting subtest: simple-bb-ctx [728.401021] Subtest simple-bb-ctx: SUCCESS (0.014s) [728.523154] [085/133] (294s left) kms_cursor_crc (cursor-offscreen-256x256) [728.767219] Starting subtest: cursor-offscreen-256x256 [728.772236] Starting dynamic subtest: pipe-A-eDP-1 [730.711151] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s) [730.740969] Starting dynamic subtest: pipe-D-eDP-1 [733.342336] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.611s) [733.344732] Subtest cursor-offscreen-256x256: SUCCESS (4.577s) [734.198089] [086/133] (288s left) gem_exec_schedule (reorder-wide) [734.381813] Subtest reorder-wide: SKIP (0.000s) [734.571275] [087/133] (288s left) kms_getfb (getfb-handle-valid) [734.660337] Starting subtest: getfb-handle-valid [734.662497] Subtest getfb-handle-valid: SUCCESS (0.000s) [734.798808] [088/133] (288s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [734.854273] Starting subtest: multi-wait-available-unsubmitted-signaled [734.856451] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [734.965792] [089/133] (287s left) gem_exec_reloc (basic-gtt-cpu-active) [735.023394] Subtest basic-gtt-cpu-active: SKIP (0.000s) [735.096683] [090/133] (287s left) perf_pmu (busy-double-start) [735.136187] Starting subtest: busy-double-start [735.138797] Starting dynamic subtest: rcs0 [738.775740] Dynamic subtest rcs0: FAIL (3.587s) [738.788611] Starting dynamic subtest: bcs0 [742.319177] Dynamic subtest bcs0: SUCCESS (3.596s) [742.337405] Starting dynamic subtest: vcs0 [746.494162] Dynamic subtest vcs0: SUCCESS (4.173s) [746.507437] Starting dynamic subtest: vcs1 [750.544314] Dynamic subtest vcs1: SUCCESS (4.048s) [750.561703] Starting dynamic subtest: vecs0 [754.483050] Dynamic subtest vecs0: SUCCESS (3.923s) [754.496471] Starting dynamic subtest: ccs0 [758.106253] Dynamic subtest ccs0: FAIL (3.566s) [758.108227] Subtest busy-double-start: FAIL (22.904s) [758.158707] [091/133] (264s left) perf_pmu (semaphore-wait) [758.196784] Starting subtest: semaphore-wait [758.199165] Starting dynamic subtest: rcs0 [758.714342] Dynamic subtest rcs0: SUCCESS (0.517s) [758.727912] Starting dynamic subtest: bcs0 [759.230748] Dynamic subtest bcs0: SUCCESS (0.512s) [759.243264] Starting dynamic subtest: vcs0 [759.747999] Dynamic subtest vcs0: SUCCESS (0.514s) [759.763212] Starting dynamic subtest: vcs1 [760.263635] Dynamic subtest vcs1: SUCCESS (0.513s) [760.276452] Starting dynamic subtest: vecs0 [760.778753] Dynamic subtest vecs0: SUCCESS (0.512s) [760.792233] Starting dynamic subtest: ccs0 [761.294344] Dynamic subtest ccs0: SUCCESS (0.512s) [761.297421] Subtest semaphore-wait: SUCCESS (3.100s) [761.413785] [092/133] (261s left) kms_content_protection (lic-type-1) [761.556681] Starting subtest: lic-type-1 [761.561189] Subtest lic-type-1: SKIP (0.000s) [761.701655] [093/133] (261s left) gem_exec_suspend (basic-s3) [761.760135] Starting subtest: basic-S3 [761.762536] Starting dynamic subtest: smem [781.421102] Dynamic subtest smem: SUCCESS (6.217s) [781.424287] Subtest basic-S3: SUCCESS (6.219s) [781.625495] [094/133] (241s left) i915_pm_rps (thresholds-idle-park) [781.789432] Starting subtest: thresholds-idle-park [781.794956] Subtest thresholds-idle-park: SKIP (0.001s) [781.941135] [095/133] (241s left) kms_lease (setcrtc-implicit-plane) [782.079401] Starting subtest: setcrtc-implicit-plane [782.081671] Starting dynamic subtest: pipe-A-eDP-1 [782.538849] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s) [782.550777] Starting dynamic subtest: pipe-B-eDP-1 [783.671324] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s) [783.682707] Starting dynamic subtest: pipe-C-eDP-1 [784.768496] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.090s) [784.779656] Starting dynamic subtest: pipe-D-eDP-1 [785.899059] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s) [785.901654] Subtest setcrtc-implicit-plane: SUCCESS (3.810s) [786.752185] [096/133] (236s left) kms_flip (2x-flip-vs-expired-vblank) [786.842205] Starting subtest: 2x-flip-vs-expired-vblank [786.850323] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s) [786.950792] [097/133] (236s left) gem_mmap_gtt (medium-copy-odd) [787.006567] Subtest medium-copy-odd: SKIP (0.000s) [787.066684] [098/133] (236s left) kms_psr (fbc-psr-sprite-render) [787.172531] Starting subtest: fbc-psr-sprite-render [787.175421] Starting dynamic subtest: eDP-1 [787.180511] Dynamic subtest eDP-1: SKIP (0.000s) [787.185667] Subtest fbc-psr-sprite-render: SKIP (0.001s) [787.248437] [099/133] (236s left) gem_unref_active_buffers [787.454274] [100/133] (235s left) i915_drm_fdinfo (virtual-idle) [787.494967] Starting subtest: virtual-idle [790.558845] Subtest virtual-idle: SUCCESS (3.058s) [790.640336] [101/133] (232s left) gem_pxp (create-valid-protected-context) [790.791560] Starting subtest: create-valid-protected-context [790.794532] Subtest create-valid-protected-context: SUCCESS (0.002s) [790.903929] [102/133] (232s left) gem_gtt_cpu_tlb [791.028020] [103/133] (232s left) perf_pmu (idle-no-semaphores) [791.068326] Starting subtest: idle-no-semaphores [791.071020] Starting dynamic subtest: rcs0 [791.608470] Dynamic subtest rcs0: SUCCESS (0.538s) [791.620246] Starting dynamic subtest: bcs0 [792.126776] Dynamic subtest bcs0: SUCCESS (0.514s) [792.140792] Starting dynamic subtest: vcs0 [792.647396] Dynamic subtest vcs0: SUCCESS (0.517s) [792.660653] Starting dynamic subtest: vcs1 [793.167389] Dynamic subtest vcs1: SUCCESS (0.515s) [793.181490] Starting dynamic subtest: vecs0 [793.687222] Dynamic subtest vecs0: SUCCESS (0.517s) [793.700495] Starting dynamic subtest: ccs0 [794.214005] Dynamic subtest ccs0: SUCCESS (0.523s) [794.217056] Subtest idle-no-semaphores: SUCCESS (3.142s) [794.326796] [104/133] (229s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [794.448041] Starting subtest: fbcpsr-1p-rte [801.480636] Subtest fbcpsr-1p-rte: SUCCESS (7.031s) [801.630141] [105/133] (221s left) i915_drm_fdinfo (busy-idle-check-all) [801.681429] Starting subtest: busy-idle-check-all [801.684142] Starting dynamic subtest: rcs0 [801.689383] Dynamic subtest rcs0: SKIP (0.003s) [801.699911] Starting dynamic subtest: bcs0 [801.705475] Dynamic subtest bcs0: SKIP (0.000s) [801.715703] Starting dynamic subtest: vcs0 [801.721037] Dynamic subtest vcs0: SKIP (0.000s) [801.731215] Starting dynamic subtest: vcs1 [801.736539] Dynamic subtest vcs1: SKIP (0.000s) [801.749587] Starting dynamic subtest: vecs0 [801.754655] Dynamic subtest vecs0: SKIP (0.000s) [801.764510] Starting dynamic subtest: ccs0 [801.770057] Dynamic subtest ccs0: SKIP (0.000s) [801.775250] Subtest busy-idle-check-all: SKIP (0.009s) [801.814427] [106/133] (221s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping) [801.924460] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping [801.929413] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s) [801.997207] [107/133] (221s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [802.103793] Starting subtest: pr-overlay-primary-update-sf-dmg-area [802.109032] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [802.175302] [108/133] (221s left) gem_ccs (block-multicopy-compressed) [802.239310] Starting subtest: block-multicopy-compressed [802.244859] Subtest block-multicopy-compressed: SKIP (0.000s) [802.349337] [109/133] (221s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [802.445281] Starting subtest: fbcpsr-2p-rte [802.449663] Subtest fbcpsr-2p-rte: SKIP (0.000s) [802.574365] [110/133] (221s left) gem_ctx_exec (basic-norecovery) [802.639003] Starting subtest: basic-norecovery [802.982999] Subtest basic-norecovery: SUCCESS (0.344s) [803.091505] [111/133] (220s left) gem_exec_schedule (noreorder-priority) [803.270549] Starting subtest: noreorder-priority [803.273427] Starting dynamic subtest: rcs0 [804.412162] Dynamic subtest rcs0: SUCCESS (1.140s) [804.425906] Starting dynamic subtest: vcs0 [806.448323] Dynamic subtest vcs0: SUCCESS (2.032s) [806.462164] Starting dynamic subtest: vcs1 [808.422562] Dynamic subtest vcs1: SUCCESS (1.970s) [808.437058] Starting dynamic subtest: vecs0 [810.412290] Dynamic subtest vecs0: SUCCESS (1.986s) [810.425983] Starting dynamic subtest: ccs0 [811.556951] Dynamic subtest ccs0: SUCCESS (1.143s) [811.559944] Subtest noreorder-priority: SUCCESS (8.283s) [811.745575] [112/133] (212s left) gem_mmap (bad-size) [811.804714] Subtest bad-size: SKIP (0.000s) [811.874601] [113/133] (212s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [811.982850] Starting subtest: plane-lut1d-ctm3x4-lut1d [812.117585] Starting dynamic subtest: pipe-A-plane-0 [812.295387] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s) [812.306171] Starting dynamic subtest: pipe-A-plane-1 [812.462623] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s) [812.475282] Starting dynamic subtest: pipe-A-plane-2 [812.595686] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s) [813.816397] Starting dynamic subtest: pipe-B-plane-0 [813.953180] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s) [813.964801] Starting dynamic subtest: pipe-B-plane-1 [814.108440] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s) [814.118562] Starting dynamic subtest: pipe-B-plane-2 [814.264327] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [815.452254] Starting dynamic subtest: pipe-C-plane-0 [815.576929] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [815.587678] Starting dynamic subtest: pipe-C-plane-1 [815.710291] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s) [815.720866] Starting dynamic subtest: pipe-C-plane-2 [815.866294] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [817.067660] Starting dynamic subtest: pipe-D-plane-0 [817.191551] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s) [817.202655] Starting dynamic subtest: pipe-D-plane-1 [817.324634] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s) [817.335565] Starting dynamic subtest: pipe-D-plane-2 [817.469480] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [817.754249] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.773s) [818.647788] [114/133] (205s left) kms_psr (psr-sprite-mmap-cpu) [818.754090] Starting subtest: psr-sprite-mmap-cpu [818.756645] Starting dynamic subtest: eDP-1 [820.581561] Dynamic subtest eDP-1: SUCCESS (1.824s) [820.584180] Subtest psr-sprite-mmap-cpu: SUCCESS (1.827s) [821.418190] [115/133] (202s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc) [821.513290] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc [821.515796] Starting dynamic subtest: pipe-A-eDP-1 [822.243000] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s) [822.254400] Starting dynamic subtest: pipe-B-eDP-1 [824.033321] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.789s) [824.045145] Starting dynamic subtest: pipe-C-eDP-1 [825.763544] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.728s) [825.774798] Starting dynamic subtest: pipe-D-eDP-1 [827.610726] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.841s) [827.613677] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.087s) [828.751176] [116/133] (195s left) kms_addfb_basic (invalid-set-prop) [828.815564] Starting subtest: invalid-set-prop [828.818408] Subtest invalid-set-prop: SUCCESS (0.000s) [828.935383] [117/133] (195s left) syncobj_timeline (wait-all-snapshot) [828.987312] Starting subtest: wait-all-snapshot [829.068300] Subtest wait-all-snapshot: SUCCESS (0.083s) [829.147093] [118/133] (194s left) kms_plane_multiple (tiling-y) [829.239504] Starting subtest: tiling-y [829.244470] Subtest tiling-y: SKIP (0.000s) [829.310500] [119/133] (194s left) vgem_basic (dmabuf-fence) [829.371480] Starting subtest: dmabuf-fence [829.374376] Subtest dmabuf-fence: SUCCESS (0.000s) [829.425361] [120/133] (194s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [829.537782] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [829.543145] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [829.644524] [121/133] (194s left) gem_close_race (multigpu-basic-threads) [829.721976] Starting subtest: multigpu-basic-threads [829.726333] Subtest multigpu-basic-threads: SKIP (0.000s) [829.935360] [122/133] (194s left) sysfs_heartbeat_interval (mixed) [829.995916] Starting subtest: mixed [829.998639] Starting dynamic subtest: vecs0 [835.235099] Dynamic subtest vecs0: SUCCESS (5.238s) [835.247905] Starting dynamic subtest: ccs0 [840.440040] Dynamic subtest ccs0: SUCCESS (5.202s) [840.453123] Starting dynamic subtest: vcs0 [845.652947] Dynamic subtest vcs0: SUCCESS (5.210s) [845.667209] Starting dynamic subtest: bcs0 [850.888491] Dynamic subtest bcs0: SUCCESS (5.232s) [850.900683] Starting dynamic subtest: rcs0 [856.088633] Dynamic subtest rcs0: SUCCESS (5.198s) [856.099684] Starting dynamic subtest: vcs1 [861.322461] Dynamic subtest vcs1: SUCCESS (5.231s) [861.325684] Subtest mixed: SUCCESS (31.323s) [861.412316] [123/133] (162s left) gem_ctx_create (basic-files) [861.485270] Starting subtest: basic-files [864.243808] Subtest basic-files: SUCCESS (2.758s) [865.504471] [124/133] (158s left) kms_big_fb (y-tiled-16bpp-rotate-180) [865.609141] Starting subtest: y-tiled-16bpp-rotate-180 [865.614457] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [865.724378] [125/133] (158s left) gen9_exec_parse (cmd-crossing-page) [865.784207] Subtest cmd-crossing-page: SKIP (0.000s) [865.858585] [126/133] (158s left) kms_flip (wf_vblank-ts-check-interruptible) [865.942154] Starting subtest: wf_vblank-ts-check-interruptible [865.944623] Starting dynamic subtest: A-eDP1 [874.890265] Dynamic subtest A-eDP1: SUCCESS (8.945s) [874.901200] Starting dynamic subtest: B-eDP1 [883.826850] Dynamic subtest B-eDP1: SUCCESS (8.934s) [883.839791] Starting dynamic subtest: C-eDP1 [892.750279] Dynamic subtest C-eDP1: SUCCESS (8.923s) [892.761357] Starting dynamic subtest: D-eDP1 [901.686516] Dynamic subtest D-eDP1: SUCCESS (8.936s) [901.691668] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.750s) [902.908240] [127/133] (121s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [903.017355] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [907.078958] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.065s) [908.219869] [128/133] (116s left) gem_mmap_gtt (basic-small-bo) [908.290458] Subtest basic-small-bo: SKIP (0.000s) [908.356679] [129/133] (116s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [908.446670] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [908.451347] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [908.518336] [130/133] (116s left) kms_big_fb (linear-8bpp-rotate-180) [908.611782] Starting subtest: linear-8bpp-rotate-180 [909.950862] Subtest linear-8bpp-rotate-180: SUCCESS (1.340s) [910.064533] [131/133] (114s left) kms_big_fb (x-tiled-32bpp-rotate-180) [910.158137] Starting subtest: x-tiled-32bpp-rotate-180 [911.659455] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.502s) [911.792883] [132/133] (112s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [911.853407] Starting subtest: yf-tiled-to-vebox-x-tiled [911.858481] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [912.038369] [133/133] (112s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [912.140102] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [912.142510] Starting dynamic subtest: pipe-A-eDP-1 [912.166159] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [912.178165] Starting dynamic subtest: pipe-B-eDP-1 [912.203540] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [912.213671] Starting dynamic subtest: pipe-C-eDP-1 [912.237736] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [912.247753] Starting dynamic subtest: pipe-D-eDP-1 [912.273278] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [912.278220] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s) [914.286912] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: syncobj_timeline results: parsing output: 2/ for test: syncobj_basic results: parsing output: 3/ for test: gem_exec_alignment results: parsing output: 4/ for test: kms_psr results: parsing output: 5/ for test: kms_cursor_crc results: parsing output: 6/ for test: api_intel_allocator results: parsing output: 7/ for test: kms_rotation_crc results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: kms_psr2_sf results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: gem_fenced_exec_thrash results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_mmap_gtt results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_plane_scaling results: parsing output: 19/ for test: gem_ctx_persistence results: parsing output: 20/ for test: kms_chamelium_hpd results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_vblank results: parsing output: 23/ for test: gem_mmap_gtt results: parsing output: 24/ for test: gem_exec_whisper results: parsing output: 25/ for test: gem_exec_reloc results: parsing output: 26/ for test: gem_workarounds results: parsing output: 27/ for test: kms_cursor_legacy results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: gem_pxp results: parsing output: 31/ for test: kms_flip results: parsing output: 32/ for test: kms_psr2_sf results: parsing output: 33/ for test: gem_eio results: parsing output: 34/ for test: kms_setmode results: parsing output: 35/ for test: kms_cursor_edge_walk results: parsing output: 36/ for test: kms_async_flips results: parsing output: 37/ for test: gem_exec_params results: parsing output: 38/ for test: gem_lmem_swapping results: parsing output: 39/ for test: kms_pm_rpm results: parsing output: 40/ for test: gem_exec_fence results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_ccs results: parsing output: 43/ for test: kms_mmap_write_crc results: parsing output: 44/ for test: gem_exec_balancer results: parsing output: 45/ for test: gem_exec_gttfill results: parsing output: 46/ for test: gem_flink_race results: parsing output: 47/ for test: gem_softpin results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: gem_exec_balancer results: parsing output: 50/ for test: syncobj_wait results: parsing output: 51/ for test: kms_ccs results: parsing output: 52/ for test: kms_hdmi_inject results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_joiner results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: prime_mmap results: parsing output: 60/ for test: kms_async_flips results: parsing output: 61/ for test: perf results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: kms_feature_discovery results: parsing output: 64/ for test: kms_plane_scaling results: parsing output: 65/ for test: kms_universal_plane results: parsing output: 66/ for test: gem_set_tiling_vs_gtt results: parsing output: 67/ for test: kms_flip_scaled_crc results: parsing output: 68/ for test: gem_ctx_param results: parsing output: 69/ for test: gem_fenced_exec_thrash results: parsing output: 70/ for test: i915_pm_rpm results: parsing output: 71/ for test: gem_render_copy results: parsing output: 72/ for test: syncobj_wait results: parsing output: 73/ for test: syncobj_eventfd results: parsing output: 74/ for test: syncobj_wait results: parsing output: 75/ for test: kms_chamelium_color results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: kms_hdr results: parsing output: 78/ for test: device_reset results: parsing output: 79/ for test: kms_pm_dc results: parsing output: 80/ for test: kms_flip results: parsing output: 81/ for test: kms_psr results: parsing output: 82/ for test: gem_exec_create results: parsing output: 83/ for test: api_intel_bb results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: kms_getfb results: parsing output: 87/ for test: syncobj_timeline results: parsing output: 88/ for test: gem_exec_reloc results: parsing output: 89/ for test: perf_pmu results: parsing output: 90/ for test: perf_pmu results: parsing output: 91/ for test: kms_content_protection results: parsing output: 92/ for test: gem_exec_suspend results: parsing output: 93/ for test: i915_pm_rps results: parsing output: 94/ for test: kms_lease results: parsing output: 95/ for test: kms_flip results: parsing output: 96/ for test: gem_mmap_gtt results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: gem_unref_active_buffers results: parsing output: 99/ for test: i915_drm_fdinfo results: parsing output: 100/ for test: gem_pxp results: parsing output: 101/ for test: gem_gtt_cpu_tlb results: parsing output: 102/ for test: perf_pmu results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: i915_drm_fdinfo results: parsing output: 105/ for test: kms_plane results: parsing output: 106/ for test: kms_psr2_sf results: parsing output: 107/ for test: gem_ccs results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_ctx_exec results: parsing output: 110/ for test: gem_exec_schedule results: parsing output: 111/ for test: gem_mmap results: parsing output: 112/ for test: kms_color_pipeline results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: kms_ccs results: parsing output: 115/ for test: kms_addfb_basic results: parsing output: 116/ for test: syncobj_timeline results: parsing output: 117/ for test: kms_plane_multiple results: parsing output: 118/ for test: vgem_basic results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_close_race results: parsing output: 121/ for test: sysfs_heartbeat_interval results: parsing output: 122/ for test: gem_ctx_create results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: gen9_exec_parse results: parsing output: 125/ for test: kms_flip results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: gem_mmap_gtt results: parsing output: 128/ for test: kms_flip_scaled_crc results: parsing output: 129/ for test: kms_big_fb results: parsing output: 130/ for test: kms_big_fb results: parsing output: 131/ for test: gem_render_copy results: parsing output: 132/ for test: kms_ccs Done.