[58.376453] Initializing watchdogs
[58.376503]   /dev/watchdog0
[58.390772] [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]
[58.395209] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.397694] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.401078] [001/133] (960s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[58.536811] Starting subtest: async-flip-with-page-flip-events-tiled
[58.907720] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[61.692508] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.788s)
[61.700352] Starting dynamic subtest: pipe-A-eDP-1-4
[63.865025] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[63.872065] Starting dynamic subtest: pipe-A-eDP-1-4
[65.873072] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[65.880761] Starting dynamic subtest: pipe-A-eDP-1-x
[68.050084] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.179s)
[68.412464] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[71.208951] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.802s)
[71.216247] Starting dynamic subtest: pipe-B-eDP-1-4
[73.394249] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[73.401601] Starting dynamic subtest: pipe-B-eDP-1-4
[75.403283] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[75.410561] Starting dynamic subtest: pipe-B-eDP-1-x
[77.615490] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.212s)
[77.999640] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[80.734433] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.738s)
[80.742889] Starting dynamic subtest: pipe-C-eDP-1-4
[82.909304] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.175s)
[82.916491] Starting dynamic subtest: pipe-C-eDP-1-4
[84.919902] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[84.927039] Starting dynamic subtest: pipe-C-eDP-1-x
[87.109492] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[87.473711] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[90.262614] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.796s)
[90.271211] Starting dynamic subtest: pipe-D-eDP-1-4
[92.451087] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s)
[92.458245] Starting dynamic subtest: pipe-D-eDP-1-4
[94.447870] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[94.455036] Starting dynamic subtest: pipe-D-eDP-1-x
[96.626497] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[96.628995] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.102s)
[97.843216] [002/133] (921s left) kms_pm_rpm (cursor-dpms)
[100.095793] Starting subtest: cursor-dpms
[100.100709] Subtest cursor-dpms: SKIP (0.000s)
[100.502321] [003/133] (918s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[100.584633] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[100.589055] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[100.650334] [004/133] (918s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[100.740730] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[100.745181] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[100.810980] [005/133] (918s left) kms_dsc (dsc-with-output-formats-with-bpc)
[100.902770] Starting subtest: dsc-with-output-formats-with-bpc
[100.957707] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[100.992426] [006/133] (918s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[101.054044] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[101.056393] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[101.151924] [007/133] (917s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[101.268876] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[101.273247] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[101.409863] [008/133] (917s left) gem_mmap_wc (coherency)
[101.454833] Subtest coherency: SKIP (0.000s)
[101.514736] [009/133] (917s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[101.606378] Starting subtest: fbc-psr2-primary-mmap-gtt
[101.608040] Starting dynamic subtest: eDP-1
[101.611480] Dynamic subtest eDP-1: SKIP (0.000s)
[101.614927] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[101.676709] [010/133] (917s left) i915_getparams_basic (basic-eu-total)
[101.726994] Starting subtest: basic-eu-total
[101.730502] Subtest basic-eu-total: SUCCESS (0.000s)
[101.811822] [011/133] (917s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[101.906849] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[101.910440] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[102.005803] [012/133] (917s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[102.107488] Starting subtest: psr2-cursor-plane-move-continuous-sf
[102.109377] Starting dynamic subtest: pipe-A-eDP-1
[112.461443] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.357s)
[112.469706] Starting dynamic subtest: pipe-B-eDP-1
[123.534822] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.070s)
[123.537204] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.430s)
[124.329111] [013/133] (895s left) i915_suspend (basic-s2idle-without-i915)
[124.372153] Starting subtest: basic-s2idle-without-i915
[143.689766] Subtest basic-s2idle-without-i915: SUCCESS (3.977s)
[143.819292] [014/133] (875s left) gem_mmap_offset (oob-read)
[143.882576] Starting subtest: oob-read
[143.884827] Subtest oob-read: SUCCESS (0.000s)
[143.993630] [015/133] (875s left) gen7_exec_parse (basic-offset)
[144.055753] Subtest basic-offset: SKIP (0.000s)
[144.117753] [016/133] (875s left) syncobj_timeline (transfer-timeline-point)
[144.172656] Starting subtest: transfer-timeline-point
[144.175123] Subtest transfer-timeline-point: SUCCESS (0.000s)
[144.291725] [017/133] (875s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[144.371221] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[144.373573] Starting dynamic subtest: pipe-A-eDP-1
[144.394102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[144.403925] Starting dynamic subtest: pipe-B-eDP-1
[144.422851] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[144.430369] Starting dynamic subtest: pipe-C-eDP-1
[144.449439] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[144.457029] Starting dynamic subtest: pipe-D-eDP-1
[144.477083] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[144.479434] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[146.644366] [018/133] (872s left) perf (invalid-create-userspace-config)
[146.768079] Starting subtest: invalid-create-userspace-config
[146.769978] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[146.808701] [019/133] (872s left) kms_rotation_crc (primary-rotation-180)
[146.895750] Starting subtest: primary-rotation-180
[153.838798] Subtest primary-rotation-180: SUCCESS (6.963s)
[155.000881] [020/133] (864s left) gem_ringfill (engines-basic)
[160.267318] Starting subtest: engines-basic
[160.269847] Starting dynamic subtest: rcs0
[160.328352] Dynamic subtest rcs0: SUCCESS (0.062s)
[160.339145] Starting dynamic subtest: bcs0
[160.371911] Dynamic subtest bcs0: SUCCESS (0.043s)
[160.381608] Starting dynamic subtest: vcs0
[160.415193] Dynamic subtest vcs0: SUCCESS (0.042s)
[160.425140] Starting dynamic subtest: vcs1
[160.459409] Dynamic subtest vcs1: SUCCESS (0.043s)
[160.476658] Starting dynamic subtest: vecs0
[160.503797] Dynamic subtest vecs0: SUCCESS (0.043s)
[160.517052] Starting dynamic subtest: ccs0
[160.549367] Dynamic subtest ccs0: SUCCESS (0.045s)
[160.552007] Subtest engines-basic: SUCCESS (0.284s)
[160.628108] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true
[160.631092] [021/133] (859s left) gem_exec_create (basic)
[160.685789] Starting subtest: basic
[160.688214] Starting dynamic subtest: smem
[164.233807] Dynamic subtest smem: SUCCESS (3.549s)
[164.236622] Subtest basic: SUCCESS (3.550s)
[164.423506] [022/133] (855s left) gem_watchdog (default-physical)
[164.491369] Starting subtest: default-physical
[166.261600] Subtest default-physical: SUCCESS (1.783s)
[166.350829] [023/133] (853s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[166.447604] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[166.452379] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[166.542904] [024/133] (853s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[166.644222] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[171.468689] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.832s)
[172.588024] [025/133] (847s left) gem_compute (compute-square)
[172.655850] Starting subtest: compute-square
[172.661330] Subtest compute-square: SUCCESS (0.007s)
[172.776477] [026/133] (847s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[172.839925] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[172.948154] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[173.021549] [027/133] (846s left) kms_sequence (queue-idle)
[173.115526] Starting subtest: queue-idle
[173.117884] Starting dynamic subtest: pipe-A-eDP-1
[174.931046] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.815s)
[174.940875] Starting dynamic subtest: pipe-B-eDP-1
[177.415329] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.481s)
[177.425161] Starting dynamic subtest: pipe-C-eDP-1
[179.859021] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.443s)
[179.868480] Starting dynamic subtest: pipe-D-eDP-1
[182.283047] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.422s)
[182.285372] Subtest queue-idle: SUCCESS (9.166s)
[183.110789] [028/133] (836s left) kms_chamelium_hpd (dp-hpd-fast)
[183.497011] Subtest dp-hpd-fast: SKIP (0.000s)
[184.327741] [029/133] (835s left) gem_mmap_wc (read)
[184.382864] Subtest read: SKIP (0.000s)
[184.445635] [030/133] (835s left) gem_exec_balancer (indices)
[184.495455] Starting subtest: indices
[187.173718] Subtest indices: SUCCESS (2.676s)
[187.466597] [031/133] (832s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[187.577592] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[187.581891] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[187.670479] [032/133] (832s left) gem_lmem_swapping (parallel-random)
[187.713386] Subtest parallel-random: SKIP (0.000s)
[187.755675] [033/133] (832s left) kms_psr (fbc-psr2-sprite-render)
[187.849804] Starting subtest: fbc-psr2-sprite-render
[187.852124] Starting dynamic subtest: eDP-1
[187.856520] Dynamic subtest eDP-1: SKIP (0.000s)
[187.860950] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[187.920364] [034/133] (832s left) syncobj_timeline (invalid-query-zero-handles)
[187.977679] Starting subtest: invalid-query-zero-handles
[187.979611] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[188.086855] [035/133] (832s left) core_auth (getclient-simple)
[188.120889] Starting subtest: getclient-simple
[188.140046] Subtest getclient-simple: SUCCESS (0.020s)
[188.242286] [036/133] (832s left) kms_fbcon_fbt (fbc)
[188.308335] Starting subtest: fbc
[194.650854] Subtest fbc: SUCCESS (6.343s)
[195.738882] [037/133] (824s left) kms_lease (lease-again)
[195.838860] Starting subtest: lease-again
[195.841251] Starting dynamic subtest: pipe-A-eDP-1
[195.843581] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[195.855002] Starting dynamic subtest: pipe-B-eDP-1
[195.857182] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[195.865820] Starting dynamic subtest: pipe-C-eDP-1
[195.868091] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[195.876193] Starting dynamic subtest: pipe-D-eDP-1
[195.878410] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[195.880629] Subtest lease-again: SUCCESS (0.012s)
[195.988050] [038/133] (824s left) gem_flink_basic (basic)
[196.045521] Starting subtest: basic
[196.047804] Subtest basic: SUCCESS (0.000s)
[196.139356] [039/133] (824s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[196.230977] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[196.233298] Starting dynamic subtest: pipe-A-eDP-1
[196.292887] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[196.303408] Starting dynamic subtest: pipe-B-eDP-1
[196.359993] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[196.369593] Starting dynamic subtest: pipe-C-eDP-1
[196.427105] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[196.437932] Starting dynamic subtest: pipe-D-eDP-1
[196.494059] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[196.498418] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[198.527116] [040/133] (821s left) perf_pmu (rc6)
[198.572247] Starting subtest: rc6
[198.574480] Starting dynamic subtest: gt0
[204.926265] Dynamic subtest gt0: SUCCESS (6.356s)
[204.938764] Starting dynamic subtest: runtime-pm-gt0
[212.691824] Dynamic subtest runtime-pm-gt0: SUCCESS (7.767s)
[212.703573] Starting dynamic subtest: runtime-pm-long-gt0
[225.118877] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.429s)
[225.130754] Starting dynamic subtest: other-idle-gt0
[231.462829] Dynamic subtest other-idle-gt0: SUCCESS (6.345s)
[231.474704] Starting dynamic subtest: gt1
[237.804282] Dynamic subtest gt1: SUCCESS (6.342s)
[237.815599] Starting dynamic subtest: runtime-pm-gt1
[245.294285] Dynamic subtest runtime-pm-gt1: SUCCESS (7.484s)
[245.306077] Starting dynamic subtest: runtime-pm-long-gt1
[257.734853] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.434s)
[257.745856] Starting dynamic subtest: other-idle-gt1
[264.077447] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[264.080498] Subtest rc6: SUCCESS (65.511s)
[265.219258] [041/133] (755s left) kms_busy (basic-hang)
[265.318508] Starting subtest: basic-hang
[265.320945] Starting dynamic subtest: flip-pipe-A
[265.920007] Dynamic subtest flip-pipe-A: SUCCESS (0.601s)
[265.930298] Starting dynamic subtest: modeset-pipe-A
[269.357116] Dynamic subtest modeset-pipe-A: SUCCESS (3.435s)
[269.366566] Starting dynamic subtest: flip-pipe-D
[270.546595] Dynamic subtest flip-pipe-D: SUCCESS (1.188s)
[270.559385] Starting dynamic subtest: modeset-pipe-D
[273.974355] Dynamic subtest modeset-pipe-D: SUCCESS (3.426s)
[273.976619] Subtest basic-hang: SUCCESS (8.657s)
[274.760958] [042/133] (745s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[274.869190] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[274.873508] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[274.950619] [043/133] (745s left) gem_eio (banned)
[275.143200] Starting subtest: banned
[275.715218] Subtest banned: SUCCESS (0.572s)
[275.842365] [044/133] (744s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[275.952721] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[275.956560] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[276.008751] [045/133] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[276.102577] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[276.106067] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[276.184904] [046/133] (744s left) kms_psr (psr2-cursor-mmap-cpu)
[276.277008] Starting subtest: psr2-cursor-mmap-cpu
[276.278825] Starting dynamic subtest: eDP-1
[277.965020] Dynamic subtest eDP-1: SUCCESS (1.688s)
[277.967433] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.689s)
[278.747157] [047/133] (742s left) perf (invalid-open-flags)
[278.814112] Starting subtest: invalid-open-flags
[278.816443] Subtest invalid-open-flags: SUCCESS (0.000s)
[278.860548] [048/133] (741s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[278.960047] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[278.964017] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[279.021477] [049/133] (741s left) gem_workarounds (suspend-resume-fd)
[279.096253] Starting subtest: suspend-resume-fd
[295.321061] Subtest suspend-resume-fd: SUCCESS (1.953s)
[295.439814] [050/133] (725s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[295.534040] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[295.536158] Starting dynamic subtest: pipe-A-eDP-1
[296.243865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.706s)
[296.256445] Starting dynamic subtest: pipe-B-eDP-1
[297.985944] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.751s)
[297.997024] Starting dynamic subtest: pipe-C-eDP-1
[299.718981] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.741s)
[299.729312] Starting dynamic subtest: pipe-D-eDP-1
[301.448109] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.735s)
[301.450431] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.938s)
[302.598489] [051/133] (718s left) syncobj_timeline (wait-zero-handles)
[302.659516] Starting subtest: wait-zero-handles
[302.662359] Subtest wait-zero-handles: SUCCESS (0.000s)
[302.737804] [052/133] (718s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[302.829971] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[308.124490] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.311s)
[309.277429] [053/133] (711s left) gem_ppgtt (blt-vs-render-ctxn)
[309.341976] Starting subtest: blt-vs-render-ctxN
[342.219832] Subtest blt-vs-render-ctxN: SUCCESS (32.893s)
[342.326779] [054/133] (678s left) gem_exec_flush (basic-uc-rw-default)
[342.441412] Starting subtest: basic-uc-rw-default
[347.904253] Subtest basic-uc-rw-default: SUCCESS (5.454s)
[348.060932] [055/133] (673s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[348.115875] Starting subtest: saturated-hostile-nopreempt
[348.118242] Starting dynamic subtest: rcs0
[348.190674] Dynamic subtest rcs0: SKIP (0.072s)
[348.203510] Starting dynamic subtest: bcs0
[348.208747] Dynamic subtest bcs0: SKIP (0.012s)
[348.219265] Starting dynamic subtest: vcs0
[348.224088] Dynamic subtest vcs0: SKIP (0.013s)
[348.234514] Starting dynamic subtest: vcs1
[348.239519] Dynamic subtest vcs1: SKIP (0.012s)
[348.249829] Starting dynamic subtest: vecs0
[348.254440] Dynamic subtest vecs0: SKIP (0.017s)
[348.264416] Starting dynamic subtest: ccs0
[348.269391] Dynamic subtest ccs0: SKIP (0.013s)
[348.274151] Subtest saturated-hostile-nopreempt: SKIP (0.143s)
[348.315142] [056/133] (672s left) i915_pm_freq_mult (media-freq)
[348.374546] Starting subtest: media-freq
[348.377032] Starting dynamic subtest: gt0
[348.381746] Dynamic subtest gt0: SKIP (0.000s)
[348.391250] Starting dynamic subtest: gt1
[348.395759] Dynamic subtest gt1: SKIP (0.000s)
[348.399995] Subtest media-freq: SKIP (0.001s)
[348.449306] [057/133] (672s left) gem_exec_schedule (preempt-queue)
[348.537205] Subtest preempt-queue: SKIP (0.000s)
[348.797335] [058/133] (672s left) perf_pmu (busy-accuracy-50)
[348.843052] Starting subtest: busy-accuracy-50
[348.845346] Starting dynamic subtest: rcs0
[350.386510] Dynamic subtest rcs0: SUCCESS (1.542s)
[350.399170] Starting dynamic subtest: bcs0
[351.932337] Dynamic subtest bcs0: SUCCESS (1.543s)
[351.943007] Starting dynamic subtest: vcs0
[353.473438] Dynamic subtest vcs0: SUCCESS (1.538s)
[353.487099] Starting dynamic subtest: vcs1
[355.015554] Dynamic subtest vcs1: SUCCESS (1.540s)
[355.028614] Starting dynamic subtest: vecs0
[356.557538] Dynamic subtest vecs0: SUCCESS (1.540s)
[356.570446] Starting dynamic subtest: ccs0
[358.106528] Dynamic subtest ccs0: SUCCESS (1.548s)
[358.109555] Subtest busy-accuracy-50: SUCCESS (9.266s)
[358.203359] [059/133] (663s left) gem_exec_fence (syncobj-export)
[358.677008] Starting subtest: syncobj-export
[358.682933] Subtest syncobj-export: SUCCESS (0.007s)
[360.570470] [060/133] (660s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[360.679957] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[361.527099] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.849s)
[361.657702] [061/133] (659s left) kms_prime (basic-crc-hybrid)
[361.739401] Subtest basic-crc-hybrid: SKIP (0.000s)
[361.788803] [062/133] (659s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[361.872481] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[361.875253] Starting dynamic subtest: pipe-A-eDP-1
[361.897290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[361.910490] Starting dynamic subtest: pipe-B-eDP-1
[361.932446] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[361.943384] Starting dynamic subtest: pipe-C-eDP-1
[361.966388] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[361.979521] Starting dynamic subtest: pipe-D-eDP-1
[362.002239] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[362.004701] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[364.114448] [063/133] (657s left) gem_ctx_freq (sysfs)
[364.176307] Starting subtest: sysfs
[364.179288] Starting dynamic subtest: gt0
[369.692202] Dynamic subtest gt0: SUCCESS (5.517s)
[369.704184] Starting dynamic subtest: gt1
[411.516998] Dynamic subtest gt1: SUCCESS (41.823s)
[411.520238] Subtest sysfs: SUCCESS (47.343s)
[411.614197] [064/133] (609s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[411.722376] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[415.631722] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.913s)
[416.815826] [065/133] (604s left) kms_joiner (basic-ultra-joiner)
[416.929672] Starting subtest: basic-ultra-joiner
[416.935026] Subtest basic-ultra-joiner: SKIP (0.000s)
[416.975104] [066/133] (604s left) gem_tiling_max_stride
[417.097886] [067/133] (604s left) kms_cursor_crc (cursor-sliding-32x10)
[417.264702] Starting subtest: cursor-sliding-32x10
[417.313233] Subtest cursor-sliding-32x10: SKIP (0.040s)
[417.550573] [068/133] (604s left) kms_content_protection (content-type-change)
[417.697233] Starting subtest: content-type-change
[417.702585] Subtest content-type-change: SKIP (0.000s)
[417.793188] [069/133] (603s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[417.851745] Starting subtest: single-wait-all-for-submit-unsubmitted
[417.961344] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[418.015535] [070/133] (603s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[418.118098] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[425.070781] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.957s)
[425.177728] [071/133] (596s left) kms_fbcon_fbt (psr-suspend)
[425.240497] Starting subtest: psr-suspend
[474.298219] Subtest psr-suspend: SUCCESS (19.823s)
[474.376116] [072/133] (547s left) syncobj_wait (reset-unsignaled)
[474.431808] Starting subtest: reset-unsignaled
[474.434176] Subtest reset-unsignaled: SUCCESS (0.000s)
[474.510775] [073/133] (547s left) syncobj_wait (single-wait-for-submit-submitted)
[474.564042] Starting subtest: single-wait-for-submit-submitted
[474.670276] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s)
[474.724584] [074/133] (547s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[474.777223] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[474.886518] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[474.942248] [075/133] (547s left) perf_pmu (semaphore-wait)
[474.987931] Starting subtest: semaphore-wait
[474.990404] Starting dynamic subtest: rcs0
[475.500647] Dynamic subtest rcs0: SUCCESS (0.514s)
[475.513215] Starting dynamic subtest: bcs0
[476.016360] Dynamic subtest bcs0: SUCCESS (0.514s)
[476.030266] Starting dynamic subtest: vcs0
[476.529699] Dynamic subtest vcs0: SUCCESS (0.512s)
[476.543671] Starting dynamic subtest: vcs1
[477.042259] Dynamic subtest vcs1: SUCCESS (0.511s)
[477.055452] Starting dynamic subtest: vecs0
[477.555809] Dynamic subtest vecs0: SUCCESS (0.513s)
[477.568956] Starting dynamic subtest: ccs0
[478.070926] Dynamic subtest ccs0: SUCCESS (0.513s)
[478.073976] Subtest semaphore-wait: SUCCESS (3.094s)
[478.172399] [076/133] (543s left) kms_atomic (plane-immutable-zpos)
[478.268990] Starting subtest: plane-immutable-zpos
[478.271233] Starting dynamic subtest: pipe-A-eDP-1
[478.898224] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.629s)
[478.900672] Subtest plane-immutable-zpos: SUCCESS (0.630s)
[479.731611] [077/133] (542s left) syncobj_timeline (reset-during-wait-for-submit)
[479.790409] Starting subtest: reset-during-wait-for-submit
[479.891883] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[479.952565] [078/133] (542s left) gem_exec_capture (userptr)
[480.013156] Starting subtest: userptr
[480.833242] Subtest userptr: SUCCESS (0.822s)
[480.932003] [079/133] (541s left) gem_busy (extended)
[481.127941] Starting subtest: extended
[481.130642] Starting dynamic subtest: rcs0
[481.206287] Dynamic subtest rcs0: SUCCESS (0.079s)
[481.219297] Starting dynamic subtest: bcs0
[481.250413] Dynamic subtest bcs0: SUCCESS (0.042s)
[481.261784] Starting dynamic subtest: vcs0
[482.793893] Dynamic subtest vcs0: SUCCESS (1.543s)
[482.808412] Starting dynamic subtest: vcs1
[484.778100] Dynamic subtest vcs1: SUCCESS (1.984s)
[484.790435] Starting dynamic subtest: vecs0
[486.825724] Dynamic subtest vecs0: SUCCESS (2.048s)
[486.840595] Starting dynamic subtest: ccs0
[486.873686] Dynamic subtest ccs0: SUCCESS (0.046s)
[486.876539] Subtest extended: SUCCESS (5.756s)
[487.088605] [080/133] (535s left) kms_flip (flip-vs-fences-interruptible)
[487.184165] Starting subtest: flip-vs-fences-interruptible
[487.189164] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[487.243763] [081/133] (534s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[487.332321] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[487.335187] Starting dynamic subtest: pipe-A
[488.377798] Dynamic subtest pipe-A: SUCCESS (1.050s)
[488.387603] Starting dynamic subtest: pipe-B
[490.546715] Dynamic subtest pipe-B: SUCCESS (2.169s)
[490.556867] Starting dynamic subtest: pipe-C
[491.731091] Dynamic subtest pipe-C: SUCCESS (1.184s)
[491.741973] Starting dynamic subtest: pipe-D
[492.882235] Dynamic subtest pipe-D: SUCCESS (1.151s)
[492.885156] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.559s)
[494.062850] [082/133] (528s left) gem_exec_schedule (timeslicing)
[494.137022] Starting subtest: timeslicing
[494.138948] Starting dynamic subtest: rcs0
[494.145180] Dynamic subtest rcs0: SUCCESS (0.022s)
[494.156397] Starting dynamic subtest: bcs0
[494.166833] Dynamic subtest bcs0: SUCCESS (0.021s)
[494.177367] Starting dynamic subtest: vcs0
[494.191874] Dynamic subtest vcs0: SUCCESS (0.024s)
[494.202378] Starting dynamic subtest: vcs1
[494.220241] Dynamic subtest vcs1: SUCCESS (0.026s)
[494.230376] Starting dynamic subtest: vecs0
[494.247102] Dynamic subtest vecs0: SUCCESS (0.025s)
[494.257273] Starting dynamic subtest: ccs0
[494.268893] Dynamic subtest ccs0: SUCCESS (0.020s)
[494.271251] Subtest timeslicing: SUCCESS (0.146s)
[495.807956] [083/133] (526s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[495.904063] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[495.908955] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[495.973106] [084/133] (526s left) kms_flip (2x-flip-vs-fences-interruptible)
[496.063554] Starting subtest: 2x-flip-vs-fences-interruptible
[496.069106] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[496.140758] [085/133] (526s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[496.237094] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[496.242380] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[496.313773] [086/133] (526s left) kms_plane_multiple (2x-tiling-none)
[496.409797] Starting subtest: 2x-tiling-none
[496.414932] Subtest 2x-tiling-none: SKIP (0.000s)
[496.460187] [087/133] (526s left) gem_mmap_gtt (basic-small-copy)
[496.520898] Subtest basic-small-copy: SKIP (0.000s)
[496.593746] [088/133] (525s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[496.686906] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[504.294508] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.614s)
[504.376211] [089/133] (518s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[504.488844] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[505.325161] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.838s)
[505.455774] [090/133] (517s left) gem_ctx_shared (detached-shared-gtt)
[505.529646] Starting subtest: detached-shared-gtt
[507.683394] Subtest detached-shared-gtt: SUCCESS (2.151s)
[508.022757] [091/133] (514s left) gem_ctx_create (basic)
[508.093449] Starting subtest: basic
[508.096076] Subtest basic: SUCCESS (0.000s)
[508.256966] [092/133] (514s left) gem_mmap_offset (ptrace)
[508.322033] Starting subtest: ptrace
[508.324166] Starting dynamic subtest: smem0-wb
[508.338381] Dynamic subtest smem0-wb: SUCCESS (0.014s)
[508.350621] Starting dynamic subtest: smem0-wc
[508.359798] Dynamic subtest smem0-wc: SUCCESS (0.020s)
[508.369540] Starting dynamic subtest: smem0-uc
[508.380009] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[508.382404] Subtest ptrace: SUCCESS (0.062s)
[508.475593] [093/133] (514s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[508.544400] Starting subtest: map-fixed-invalidate-overlap-busy
[508.549653] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[508.642199] [094/133] (514s left) kms_big_fb (x-tiled-addfb)
[508.745369] Starting subtest: x-tiled-addfb
[508.748146] Subtest x-tiled-addfb: SUCCESS (0.000s)
[508.816824] [095/133] (513s left) prime_mmap (test_invalid_sync_flags)
[508.869376] Starting subtest: test_invalid_sync_flags
[508.872199] Starting dynamic subtest: test_invalid_sync_flags-smem
[508.875062] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[508.877505] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[508.962831] [096/133] (513s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[509.047836] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[509.050183] Starting dynamic subtest: pipe-A-eDP-1
[510.415697] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.367s)
[510.700253] Starting dynamic subtest: pipe-B-eDP-1
[511.738626] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.048s)
[512.020121] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.972s)
[512.846929] [097/133] (510s left) kms_debugfs (display-on-read-all)
[512.945181] Starting subtest: display-on-read-all
[513.114132] Subtest display-on-read-all: SUCCESS (0.169s)
[513.203426] [098/133] (509s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[513.304410] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[520.039301] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.739s)
[520.146928] [099/133] (502s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[520.269340] Starting subtest: cursorB-vs-flipB-atomic
[520.274094] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[520.387709] [100/133] (502s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[520.475837] Starting subtest: 4-tiled-64bpp-rotate-180
[521.966288] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.491s)
[522.089928] [101/133] (500s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[522.195183] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[522.200098] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[522.276727] [102/133] (500s left) perf_pmu (pmu-read)
[522.318069] Starting subtest: pmu-read
[522.320680] Subtest pmu-read: SUCCESS (0.002s)
[522.398601] [103/133] (500s left) kms_psr (psr-sprite-plane-onoff)
[522.488622] Starting subtest: psr-sprite-plane-onoff
[522.490926] Starting dynamic subtest: eDP-1
[524.251218] Dynamic subtest eDP-1: SUCCESS (1.761s)
[524.253674] Subtest psr-sprite-plane-onoff: SUCCESS (1.762s)
[525.053303] [104/133] (498s left) kms_hdr (invalid-hdr)
[525.142068] Starting subtest: invalid-hdr
[527.263057] Starting dynamic subtest: pipe-A-eDP-1
[530.145387] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.884s)
[530.148526] Subtest invalid-hdr: SUCCESS (5.006s)
[530.222259] [105/133] (493s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[530.427415] Starting subtest: cursor-rapid-movement-128x128
[530.442397] Starting dynamic subtest: pipe-A-eDP-1
[532.027130] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.585s)
[532.061321] Starting dynamic subtest: pipe-D-eDP-1
[533.234196] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.179s)
[533.236973] Subtest cursor-rapid-movement-128x128: SUCCESS (2.805s)
[534.080711] [106/133] (489s left) kms_psr (psr-cursor-render)
[534.181602] Starting subtest: psr-cursor-render
[534.184197] Starting dynamic subtest: eDP-1
[535.897398] Dynamic subtest eDP-1: SUCCESS (1.716s)
[535.899982] Subtest psr-cursor-render: SUCCESS (1.717s)
[536.740972] [107/133] (486s left) gem_exec_reloc (basic-wc-read-active)
[536.804067] Subtest basic-wc-read-active: SKIP (0.000s)
[536.882720] [108/133] (486s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[536.984248] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[536.989154] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[537.057613] [109/133] (486s left) gem_exec_schedule (implicit-boths)
[537.127060] Starting subtest: implicit-boths
[537.129343] Starting dynamic subtest: rcs0
[537.235278] Dynamic subtest rcs0: SUCCESS (0.119s)
[537.246065] Starting dynamic subtest: vcs0
[537.326889] Dynamic subtest vcs0: SUCCESS (0.091s)
[537.343427] Starting dynamic subtest: vcs1
[537.413379] Dynamic subtest vcs1: SUCCESS (0.085s)
[537.429802] Starting dynamic subtest: vecs0
[537.496370] Dynamic subtest vecs0: SUCCESS (0.082s)
[537.510122] Starting dynamic subtest: ccs0
[537.587849] Dynamic subtest ccs0: SUCCESS (0.091s)
[537.590668] Subtest implicit-boths: SUCCESS (0.472s)
[538.864960] [110/133] (484s left) gem_eio (in-flight-contexts-immediate)
[539.091278] Starting subtest: in-flight-contexts-immediate
[552.828133] Subtest in-flight-contexts-immediate: SUCCESS (13.739s)
[552.924642] [111/133] (470s left) api_intel_allocator (alloc-simple)
[552.989060] Starting subtest: alloc-simple
[552.991633] Subtest alloc-simple: SUCCESS (0.004s)
[553.082267] [112/133] (470s left) gem_softpin (allocator-basic)
[553.135680] Starting subtest: allocator-basic
[553.194899] Subtest allocator-basic: SUCCESS (0.061s)
[553.290868] [113/133] (470s left) gem_exec_whisper (basic-contexts)
[553.350865] Starting subtest: basic-contexts
[559.815286] Subtest basic-contexts: SUCCESS (6.463s)
[559.975769] [114/133] (463s left) kms_flip (2x-flip-vs-expired-vblank)
[560.072675] Starting subtest: 2x-flip-vs-expired-vblank
[560.084351] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[560.191963] [115/133] (463s left) i915_drm_fdinfo (memory-info-shared)
[560.256118] Starting subtest: memory-info-shared
[560.258425] Starting dynamic subtest: smem0
[560.288297] Dynamic subtest smem0: SUCCESS (0.035s)
[560.291423] Subtest memory-info-shared: SUCCESS (0.036s)
[560.359049] [116/133] (463s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[560.470624] Starting subtest: psr-shrfb-scaledprimary
[566.210122] Subtest psr-shrfb-scaledprimary: SUCCESS (5.745s)
[566.316192] [117/133] (457s left) gem_render_copy (yf-tiled-ccs-to-linear)
[566.380135] Starting subtest: yf-tiled-ccs-to-linear
[566.385469] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[566.543794] [118/133] (457s left) kms_chamelium_frames (dp-crc-single)
[566.933115] Subtest dp-crc-single: SKIP (0.000s)
[567.775381] [119/133] (456s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[567.871262] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[567.876317] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[567.946809] [120/133] (455s left) kms_vblank (ts-continuation-idle-hang)
[568.036389] Starting subtest: ts-continuation-idle-hang
[568.039279] Starting dynamic subtest: pipe-A-eDP-1
[594.537385] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.491s)
[594.553727] Starting dynamic subtest: pipe-D-eDP-1
[619.570210] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.031s)
[619.572169] Subtest ts-continuation-idle-hang: SUCCESS (51.527s)
[620.355505] [121/133] (403s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[620.447970] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[620.452930] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[620.520550] [122/133] (403s left) gem_readwrite (read-bad-handle)
[620.575604] Subtest read-bad-handle: SKIP (0.000s)
[620.637771] [123/133] (403s left) kms_cursor_crc (cursor-onscreen-128x42)
[620.862256] Starting subtest: cursor-onscreen-128x42
[620.908082] Subtest cursor-onscreen-128x42: SKIP (0.039s)
[621.091829] [124/133] (403s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[621.180553] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[621.183035] Starting dynamic subtest: pipe-A-eDP-1
[653.539296] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.880s)
[653.552871] Starting dynamic subtest: pipe-B-eDP-1
[686.492221] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.699s)
[686.504391] Starting dynamic subtest: pipe-C-eDP-1
[719.447078] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.706s)
[719.458867] Starting dynamic subtest: pipe-D-eDP-1
[752.438379] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.633s)
[752.440747] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.922s)
[753.649857] [125/133] (270s left) i915_query (query-topology-kernel-writes)
[753.715675] Starting subtest: query-topology-kernel-writes
[753.717654] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[753.788242] [126/133] (270s left) kms_properties (colorop-properties-atomic)
[753.885063] Starting subtest: colorop-properties-atomic
[753.886930] Starting dynamic subtest: pipe-A-eDP-1
[754.225533] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.341s)
[754.236930] Starting dynamic subtest: pipe-B-eDP-1
[755.314453] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.092s)
[755.324684] Starting dynamic subtest: pipe-C-eDP-1
[756.349628] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.037s)
[756.362022] Starting dynamic subtest: pipe-D-eDP-1
[757.380213] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.031s)
[757.382445] Subtest colorop-properties-atomic: SUCCESS (3.507s)
[758.158225] [127/133] (266s left) kms_plane_alpha_blend (alpha-basic)
[758.252882] Starting subtest: alpha-basic
[758.531049] Starting dynamic subtest: pipe-A-eDP-1
[760.474861] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.947s)
[760.505607] Starting dynamic subtest: pipe-D-eDP-1
[763.149393] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.657s)
[763.151872] Subtest alpha-basic: SUCCESS (4.907s)
[763.935229] [128/133] (260s left) kms_color (legacy-gamma-reset)
[764.028597] Starting subtest: legacy-gamma-reset
[764.030694] Starting dynamic subtest: pipe-A-eDP-1
[764.416138] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.390s)
[764.426949] Starting dynamic subtest: pipe-B-eDP-1
[764.431543] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.013s)
[764.443916] Starting dynamic subtest: pipe-C-eDP-1
[764.446150] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[764.456055] Starting dynamic subtest: pipe-D-eDP-1
[764.458410] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[764.460552] Subtest legacy-gamma-reset: SUCCESS (0.431s)
[765.197489] [129/133] (259s left) kms_plane_scaling (invalid-num-scalers)
[765.283824] Starting subtest: invalid-num-scalers
[765.286020] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[765.306608] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.022s)
[765.317448] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[765.341914] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[765.352730] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[765.373206] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[765.383640] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[765.404233] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[765.406526] Subtest invalid-num-scalers: SUCCESS (0.121s)
[765.492984] [130/133] (258s left) gem_exec_basic (basic)
[765.559352] Starting subtest: basic
[765.561522] Starting dynamic subtest: rcs0-smem
[765.563828] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[765.575869] Starting dynamic subtest: bcs0-smem
[765.578138] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[765.588712] Starting dynamic subtest: vcs0-smem
[765.590981] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[765.601267] Starting dynamic subtest: vcs1-smem
[765.603382] Dynamic subtest vcs1-smem: SUCCESS (0.003s)
[765.613850] Starting dynamic subtest: vecs0-smem
[765.615982] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[765.626277] Starting dynamic subtest: ccs0-smem
[765.628486] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[765.630667] Subtest basic: SUCCESS (0.031s)
[767.176595] [131/133] (257s left) core_getversion (all-cards)
[767.216603] Starting subtest: all-cards
[767.224004] Subtest all-cards: SUCCESS (0.011s)
[767.279015] [132/133] (257s left) gem_lmem_swapping (parallel-random-verify)
[767.328163] Subtest parallel-random-verify: SKIP (0.000s)
[767.380187] [133/133] (257s left) kms_psr2_su (page_flip-xrgb8888)
[767.431884] Subtest page_flip-XRGB8888: SKIP (0.000s)
[767.490670] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: kms_dsc
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: gem_mmap_wc
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: i915_getparams_basic
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: i915_suspend
results: parsing output: 13/ for test: gem_mmap_offset
results: parsing output: 14/ for test: gen7_exec_parse
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_rotation_crc
results: parsing output: 19/ for test: gem_ringfill
results: parsing output: 20/ for test: gem_exec_create
results: parsing output: 21/ for test: gem_watchdog
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_compute
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: kms_sequence
results: parsing output: 27/ for test: kms_chamelium_hpd
results: parsing output: 28/ for test: gem_mmap_wc
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_lmem_swapping
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: core_auth
results: parsing output: 35/ for test: kms_fbcon_fbt
results: parsing output: 36/ for test: kms_lease
results: parsing output: 37/ for test: gem_flink_basic
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_busy
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: kms_plane
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_workarounds
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_ppgtt
results: parsing output: 53/ for test: gem_exec_flush
results: parsing output: 54/ for test: gem_ctx_persistence
results: parsing output: 55/ for test: i915_pm_freq_mult
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_prime
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gem_ctx_freq
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_joiner
results: parsing output: 65/ for test: gem_tiling_max_stride
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_content_protection
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_fbcon_fbt
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_atomic
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: gem_exec_capture
results: parsing output: 78/ for test: gem_busy
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_plane_scaling
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_plane_multiple
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_ctx_shared
results: parsing output: 90/ for test: gem_ctx_create
results: parsing output: 91/ for test: gem_mmap_offset
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: prime_mmap
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: kms_debugfs
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: perf_pmu
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_hdr
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: api_intel_allocator
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: i915_drm_fdinfo
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_render_copy
results: parsing output: 117/ for test: kms_chamelium_frames
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_vblank
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_readwrite
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: i915_query
results: parsing output: 125/ for test: kms_properties
results: parsing output: 126/ for test: kms_plane_alpha_blend
results: parsing output: 127/ for test: kms_color
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: gem_exec_basic
results: parsing output: 130/ for test: core_getversion
results: parsing output: 131/ for test: gem_lmem_swapping
results: parsing output: 132/ for test: kms_psr2_su
Done.