[57.044131] Initializing watchdogs
[57.044261]   /dev/watchdog0
[57.060801] [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.065623] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.067891] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.070088] [001/131] (960s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[57.161699] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[57.162726] Starting dynamic subtest: pipe-A-eDP-1
[57.171582] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[57.178225] Starting dynamic subtest: pipe-B-eDP-1
[57.187096] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[57.192391] Starting dynamic subtest: pipe-C-eDP-1
[57.201226] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[57.206162] Starting dynamic subtest: pipe-D-eDP-1
[57.214560] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[57.216211] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.002s)
[59.368779] [002/131] (958s left) i915_query (query-topology-known-pci-ids)
[59.415443] Starting subtest: query-topology-known-pci-ids
[59.417350] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[59.488217] [003/131] (958s left) intel_hwmon (hwmon-write)
[59.537086] Subtest hwmon-write: SKIP (0.000s)
[59.594611] [004/131] (958s left) gem_exec_balancer (hog)
[59.649024] Starting subtest: hog
[59.650933] Subtest hog: SKIP (0.000s)
[59.944418] [005/131] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[60.041270] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[63.790424] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.747s)
[64.957095] [006/131] (952s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[65.048681] Starting subtest: crc-primary-suspend-y-tiled-ccs
[65.049806] Starting dynamic subtest: pipe-A-eDP-1
[65.053711] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[65.060513] Starting dynamic subtest: pipe-B-eDP-1
[65.064086] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[65.069910] Starting dynamic subtest: pipe-C-eDP-1
[65.073639] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[65.079324] Starting dynamic subtest: pipe-D-eDP-1
[65.082762] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[65.084554] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.003s)
[67.302114] [007/131] (950s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[67.400975] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[67.402725] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[67.504600] [008/131] (950s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[72.545246] Starting subtest: pr-primary-plane-update-sf-dmg-area
[72.548018] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[73.388601] [009/131] (944s left) gem_lmem_swapping (massive-random)
[73.424230] Subtest massive-random: SKIP (0.000s)
[73.461168] [010/131] (944s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[73.555699] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[73.556589] Starting dynamic subtest: pipe-A-default-mode
[74.665214] Dynamic subtest pipe-A-default-mode: SKIP (1.107s)
[74.667380] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.108s)
[74.822061] [011/131] (943s left) gem_exec_reloc (basic-write-gtt)
[74.881453] Subtest basic-write-gtt: SKIP (0.000s)
[74.952640] [012/131] (942s left) kms_cursor_crc (cursor-sliding-64x21)
[75.133545] Starting subtest: cursor-sliding-64x21
[75.174412] Subtest cursor-sliding-64x21: SKIP (0.039s)
[75.398525] [013/131] (942s left) gem_ctx_persistence (legacy-engines-mixed)
[75.459763] Starting subtest: legacy-engines-mixed
[75.460944] Starting dynamic subtest: render
[75.556389] Dynamic subtest render: SUCCESS (0.097s)
[75.565163] Starting dynamic subtest: bsd1
[75.625470] Dynamic subtest bsd1: SUCCESS (0.068s)
[75.633097] Starting dynamic subtest: bsd2
[75.692735] Dynamic subtest bsd2: SUCCESS (0.066s)
[75.699068] Starting dynamic subtest: blt
[75.768269] Dynamic subtest blt: SUCCESS (0.074s)
[75.777549] Starting dynamic subtest: vebox
[75.842950] Dynamic subtest vebox: SUCCESS (0.074s)
[75.844357] Subtest legacy-engines-mixed: SUCCESS (0.383s)
[75.909987] [014/131] (942s left) kms_psr (psr2-sprite-plane-onoff)
[75.991771] Starting subtest: psr2-sprite-plane-onoff
[75.992758] Starting dynamic subtest: eDP-1
[77.716992] Dynamic subtest eDP-1: SUCCESS (1.724s)
[77.718253] Subtest psr2-sprite-plane-onoff: SUCCESS (1.724s)
[78.570963] [015/131] (939s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[78.668879] Starting subtest: x-tiled-16bpp-rotate-180
[80.107244] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.439s)
[80.272776] [016/131] (937s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[80.368525] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[87.360790] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.992s)
[87.497942] [017/131] (930s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[87.594995] Starting subtest: fbc-psr-sprite-mmap-gtt
[87.596186] Starting dynamic subtest: eDP-1
[87.598097] Dynamic subtest eDP-1: SKIP (0.000s)
[87.599947] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[87.658758] [018/131] (930s left) kms_big_fb (x-tiled-addfb)
[87.756107] Starting subtest: x-tiled-addfb
[87.757160] Subtest x-tiled-addfb: SUCCESS (0.000s)
[87.872298] [019/131] (930s left) gem_ccs (large-ctrl-surf-copy)
[87.924276] Starting subtest: large-ctrl-surf-copy
[87.926306] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[88.037618] [020/131] (930s left) perf_pmu (module-unload)
[88.124903] Starting subtest: module-unload
[94.741922] Subtest module-unload: FAIL (6.582s)
[94.759944] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[94.761426] [021/131] (923s left) gem_workarounds (basic-read-context)
[96.240309] Starting subtest: basic-read-context
[96.265379] Subtest basic-read-context: SUCCESS (0.026s)
[96.367372] [FACT gem_workarounds (basic-read-context)] new: kernel.kmod_is_loaded.i915: true
[96.369483] [022/131] (921s left) gen7_exec_parse (bitmasks)
[96.418360] Subtest bitmasks: SKIP (0.000s)
[96.467459] [023/131] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[96.555889] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[96.557748] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[96.636302] [024/131] (921s left) sriov_basic (enable-vfs-autoprobe-off)
[96.690726] Starting subtest: enable-vfs-autoprobe-off
[96.691982] Starting dynamic subtest: numvfs-1
[96.720617] Dynamic subtest numvfs-1: FAIL (0.005s)
[96.727904] Starting dynamic subtest: numvfs-2
[96.756631] Dynamic subtest numvfs-2: FAIL (0.003s)
[96.762765] Starting dynamic subtest: numvfs-3
[96.790519] Dynamic subtest numvfs-3: FAIL (0.003s)
[96.796670] Starting dynamic subtest: numvfs-4
[96.823672] Dynamic subtest numvfs-4: FAIL (0.003s)
[96.829856] Starting dynamic subtest: numvfs-5
[96.856905] Dynamic subtest numvfs-5: FAIL (0.003s)
[96.862808] Starting dynamic subtest: numvfs-6
[96.890188] Dynamic subtest numvfs-6: FAIL (0.003s)
[96.895875] Starting dynamic subtest: numvfs-7
[96.923591] Dynamic subtest numvfs-7: FAIL (0.004s)
[96.929454] Starting dynamic subtest: numvfs-random
[96.958699] Dynamic subtest numvfs-random: FAIL (0.003s)
[96.965807] Starting dynamic subtest: numvfs-all
[96.998421] Dynamic subtest numvfs-all: FAIL (0.004s)
[96.999334] Subtest enable-vfs-autoprobe-off: FAIL (0.035s)
[97.025324] [025/131] (921s left) kms_plane_scaling (invalid-parameters)
[97.120611] Starting subtest: invalid-parameters
[97.121587] Starting dynamic subtest: less-than-1-height-src
[97.132187] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[97.138535] Starting dynamic subtest: less-than-1-width-src
[97.146116] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[97.147032] Subtest invalid-parameters: SUCCESS (0.026s)
[97.235360] [026/131] (921s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[97.329903] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[97.331038] Starting dynamic subtest: pipe-A-default-mode
[97.618665] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[97.620429] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.287s)
[98.402239] [027/131] (919s left) api_intel_bb (misplaced-blitter)
[98.445474] Starting subtest: misplaced-blitter
[98.451937] Subtest misplaced-blitter: SUCCESS (0.007s)
[98.595349] [028/131] (919s left) kms_chamelium_audio (dp-audio-edid)
[98.974823] Subtest dp-audio-edid: SKIP (0.000s)
[99.807563] [029/131] (918s left) template (b)
[99.860374] Starting subtest: B
[99.861449] Subtest B: SUCCESS (0.000s)
[99.968478] [030/131] (918s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[100.071296] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[101.137098] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.066s)
[101.282675] [031/131] (917s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[101.377060] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[101.378749] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[101.468949] [032/131] (916s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[101.525178] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[101.526946] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[101.696962] [033/131] (916s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[101.797090] Starting subtest: yf-tiled-addfb-size-offset-overflow
[101.798958] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[101.889062] [034/131] (916s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[102.007882] Starting subtest: protected-encrypted-src-copy-not-readible
[102.120607] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.112s)
[102.234091] [035/131] (916s left) kms_chamelium_frames (dp-crc-multiple)
[102.607515] Subtest dp-crc-multiple: SKIP (0.000s)
[103.433285] [036/131] (915s left) kms_invalid_mode (bad-vsync-end)
[103.514782] Starting subtest: bad-vsync-end
[103.515853] Starting dynamic subtest: pipe-A-eDP-1
[103.813235] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[103.822059] Starting dynamic subtest: pipe-B-eDP-1
[103.822967] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[103.829514] Starting dynamic subtest: pipe-C-eDP-1
[103.830469] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[103.836799] Starting dynamic subtest: pipe-D-eDP-1
[103.837818] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[103.838872] Subtest bad-vsync-end: SUCCESS (0.303s)
[104.588136] [037/131] (914s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[104.975938] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[105.790285] [038/131] (912s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[105.883208] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[105.885064] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[105.982569] [039/131] (912s left) gem_ctx_param (basic)
[106.037417] Starting subtest: basic
[106.039863] Subtest basic: SUCCESS (0.001s)
[106.145999] [040/131] (912s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[106.235723] Starting subtest: 2x-absolute-wf_vblank-interruptible
[106.247137] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[106.311212] [041/131] (912s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[106.427446] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[107.858480] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.430s)
[108.649071] [042/131] (910s left) kms_psr (psr2-dpms)
[108.737098] Starting subtest: psr2-dpms
[108.738097] Starting dynamic subtest: eDP-1
[111.669970] Dynamic subtest eDP-1: SUCCESS (2.933s)
[111.671025] Subtest psr2-dpms: SUCCESS (2.934s)
[112.525724] [043/131] (906s left) gem_exec_schedule (implicit-write-read)
[112.581148] Starting subtest: implicit-write-read
[112.582169] Starting dynamic subtest: rcs0
[112.686730] Dynamic subtest rcs0: SUCCESS (0.106s)
[112.700728] Starting dynamic subtest: vcs0
[112.774295] Dynamic subtest vcs0: SUCCESS (0.087s)
[112.787046] Starting dynamic subtest: vcs1
[112.851383] Dynamic subtest vcs1: SUCCESS (0.077s)
[112.861536] Starting dynamic subtest: vecs0
[112.924144] Dynamic subtest vecs0: SUCCESS (0.072s)
[112.934487] Starting dynamic subtest: ccs0
[113.006770] Dynamic subtest ccs0: SUCCESS (0.082s)
[113.008114] Subtest implicit-write-read: SUCCESS (0.427s)
[114.020048] [044/131] (904s left) prime_vgem (basic-read)
[114.100236] Starting subtest: basic-read
[114.106655] Subtest basic-read: SKIP (0.005s)
[114.201343] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[114.202972] [045/131] (904s left) kms_pm_rpm (drm-resources-equal)
[116.041019] Starting subtest: drm-resources-equal
[121.079799] Subtest drm-resources-equal: SUCCESS (5.039s)
[121.159628] [046/131] (897s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[121.263880] Starting subtest: y-tiled-16bpp-rotate-0
[121.265628] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[121.372936] [047/131] (897s left) dumb_buffer (map-invalid-size)
[121.423784] Starting subtest: map-invalid-size
[121.424751] Subtest map-invalid-size: SUCCESS (0.000s)
[121.536320] [048/131] (897s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[121.632849] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[121.634797] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[121.723136] [049/131] (897s left) kms_universal_plane (universal-plane-functional)
[121.814783] Starting subtest: universal-plane-functional
[121.815848] Starting dynamic subtest: pipe-A-eDP-1
[125.716535] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.900s)
[125.724091] Starting dynamic subtest: pipe-B-eDP-1
[130.194552] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.478s)
[130.201996] Starting dynamic subtest: pipe-C-eDP-1
[134.528140] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.332s)
[134.534943] Starting dynamic subtest: pipe-D-eDP-1
[138.807433] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.278s)
[138.808581] Subtest universal-plane-functional: SUCCESS (16.993s)
[139.580894] [050/131] (879s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[139.682216] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[139.683875] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[139.776128] [051/131] (879s left) i915_drm_fdinfo (virtual-busy-hang)
[139.808496] Starting subtest: virtual-busy-hang
[139.810710] Subtest virtual-busy-hang: SKIP (0.000s)
[139.863434] [052/131] (879s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[139.905738] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[139.906587] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[140.005742] [053/131] (879s left) gem_partial_pwrite_pread (reads-snoop)
[140.064128] Subtest reads-snoop: SKIP (0.000s)
[140.149143] [054/131] (878s left) kms_cursor_crc (async-cursor-crc-framebuffer-change)
[140.256443] Starting subtest: async-cursor-crc-framebuffer-change
[140.257476] Starting dynamic subtest: pipe-A-eDP-1
[140.856975] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[140.865111] Starting dynamic subtest: pipe-D-eDP-1
[142.129960] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.270s)
[142.130967] Subtest async-cursor-crc-framebuffer-change: SUCCESS (1.872s)
[142.936875] [055/131] (876s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[143.034953] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[143.036815] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[143.128986] [056/131] (876s left) gem_exec_gttfill (engines)
[143.187157] Starting subtest: engines
[143.188255] Starting dynamic subtest: rcs0
[167.740402] Dynamic subtest rcs0: SUCCESS (24.548s)
[167.750174] Starting dynamic subtest: bcs0
[192.939905] Dynamic subtest bcs0: SUCCESS (25.196s)
[192.947878] Starting dynamic subtest: vcs0
[218.136330] Dynamic subtest vcs0: SUCCESS (25.193s)
[218.145508] Starting dynamic subtest: vcs1
[243.369058] Dynamic subtest vcs1: SUCCESS (25.231s)
[243.379356] Starting dynamic subtest: vecs0
[268.542964] Dynamic subtest vecs0: SUCCESS (25.172s)
[268.552813] Starting dynamic subtest: ccs0
[293.748232] Dynamic subtest ccs0: SUCCESS (25.202s)
[293.749428] Subtest engines: SUCCESS (150.553s)
[293.925969] [057/131] (725s left) gem_eio (in-flight-10ms)
[294.197362] Starting subtest: in-flight-10ms
[302.964172] Subtest in-flight-10ms: SUCCESS (8.766s)
[303.142773] [058/131] (716s left) kms_lease (lease-uevent)
[303.235812] Starting subtest: lease-uevent
[304.246684] Subtest lease-uevent: SUCCESS (1.010s)
[304.316603] [059/131] (714s left) gem_exec_schedule (submit-early-slice)
[304.375271] Starting subtest: submit-early-slice
[304.376339] Starting dynamic subtest: rcs0
[304.419768] Dynamic subtest rcs0: SUCCESS (0.044s)
[304.430413] Starting dynamic subtest: bcs0
[304.459619] Dynamic subtest bcs0: SUCCESS (0.040s)
[304.467717] Starting dynamic subtest: vcs0
[304.495555] Dynamic subtest vcs0: SUCCESS (0.035s)
[304.505879] Starting dynamic subtest: vcs1
[304.533977] Dynamic subtest vcs1: SUCCESS (0.038s)
[304.542760] Starting dynamic subtest: vecs0
[304.575287] Dynamic subtest vecs0: SUCCESS (0.041s)
[304.585267] Starting dynamic subtest: ccs0
[304.617178] Dynamic subtest ccs0: SUCCESS (0.041s)
[304.618250] Subtest submit-early-slice: SUCCESS (0.242s)
[305.963493] [060/131] (713s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[306.063801] Starting subtest: psr-rgb565-draw-pwrite
[312.933146] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.868s)
[313.029037] [061/131] (706s left) kms_force_connector_basic (force-edid)
[313.105430] Starting subtest: force-edid
[313.439995] Subtest force-edid: SUCCESS (0.335s)
[313.591573] [062/131] (705s left) syncobj_wait (multi-wait-all-signaled)
[313.659507] Starting subtest: multi-wait-all-signaled
[313.660585] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[313.766896] [063/131] (705s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[313.829268] Starting subtest: stress-mm-invalidate-close-overlap
[315.981247] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[316.115754] [064/131] (703s left) kms_psr (fbc-pr-primary-blt)
[316.215116] Starting subtest: fbc-pr-primary-blt
[316.216865] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[316.283173] [065/131] (703s left) kms_flip (basic-flip-vs-wf_vblank)
[316.379584] Starting subtest: basic-flip-vs-wf_vblank
[316.381997] Starting dynamic subtest: A-eDP1
[318.365335] Dynamic subtest A-eDP1: SUCCESS (1.983s)
[318.375241] Starting dynamic subtest: B-eDP1
[320.269342] Dynamic subtest B-eDP1: SUCCESS (1.903s)
[320.277729] Starting dynamic subtest: C-eDP1
[322.158830] Dynamic subtest C-eDP1: SUCCESS (1.888s)
[322.170186] Starting dynamic subtest: D-eDP1
[324.053831] Dynamic subtest D-eDP1: SUCCESS (1.894s)
[324.056214] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.676s)
[325.242555] [066/131] (694s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[325.341533] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[325.343356] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[325.457131] [067/131] (694s left) gem_mmap_gtt (basic-write-read)
[325.506941] Subtest basic-write-read: SKIP (0.000s)
[325.559748] [068/131] (694s left) gem_exercise_blt (fast-copy-emit)
[325.607953] Starting subtest: fast-copy-emit
[325.609154] Starting dynamic subtest: linear-smem-smem-emit
[325.632390] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.024s)
[325.642225] Starting dynamic subtest: xmajor-smem-smem-emit
[325.650127] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[325.657697] Starting dynamic subtest: tile4-smem-smem-emit
[325.668158] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s)
[325.675763] Starting dynamic subtest: tile64-smem-smem-emit
[325.686124] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[325.687096] Subtest fast-copy-emit: SUCCESS (0.079s)
[325.814507] [069/131] (693s left) kms_cursor_crc (cursor-suspend)
[325.936743] Starting subtest: cursor-suspend
[325.937618] Starting dynamic subtest: pipe-A-eDP-1
[358.963244] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.223s)
[358.976989] Starting dynamic subtest: pipe-D-eDP-1
[392.932378] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.615s)
[392.933538] Subtest cursor-suspend: SUCCESS (6.840s)
[393.732709] [070/131] (625s left) gem_eio (wait-10ms)
[393.950566] Starting subtest: wait-10ms
[394.315548] Subtest wait-10ms: SUCCESS (0.366s)
[394.479351] [071/131] (625s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[394.573123] Starting subtest: drrs-dirtyfb-ioctl
[394.578569] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[394.677883] [072/131] (625s left) gem_ctx_param (invalid-get-no-zeromap)
[394.728203] Starting subtest: invalid-get-no-zeromap
[394.729610] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[394.837315] [073/131] (624s left) kms_color (ctm-0-75)
[394.922972] Starting subtest: ctm-0-75
[394.924169] Starting dynamic subtest: pipe-A-eDP-1
[399.831720] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.904s)
[399.843638] Starting dynamic subtest: pipe-B-eDP-1
[405.396841] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.564s)
[405.409176] Starting dynamic subtest: pipe-C-eDP-1
[410.638189] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.237s)
[410.650412] Starting dynamic subtest: pipe-D-eDP-1
[415.810852] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.172s)
[415.811773] Subtest ctm-0-75: SUCCESS (20.880s)
[416.639562] [074/131] (603s left) gen9_exec_parse (cmd-crossing-page)
[416.703743] Subtest cmd-crossing-page: SKIP (0.000s)
[416.778274] [075/131] (603s left) gem_eio (in-flight-internal-immediate)
[417.003954] Starting subtest: in-flight-internal-immediate
[418.155172] Subtest in-flight-internal-immediate: SUCCESS (1.151s)
[418.264374] [076/131] (601s left) kms_cursor_crc (cursor-random-32x32)
[418.405458] Starting subtest: cursor-random-32x32
[418.447214] Subtest cursor-random-32x32: SKIP (0.040s)
[418.748620] [077/131] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[418.839104] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[418.840853] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[418.957227] [078/131] (600s left) gem_ppgtt (shrink-vs-evict-pinned)
[419.015336] Starting subtest: shrink-vs-evict-pinned
[425.074364] Subtest shrink-vs-evict-pinned: SUCCESS (6.056s)
[425.149649] [079/131] (594s left) i915_pciid
[425.295112] [080/131] (594s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[425.388188] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[425.390084] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[425.505341] [081/131] (594s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[425.598769] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[425.610358] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[425.737597] [082/131] (594s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[425.797712] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[425.798722] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[425.910374] [083/131] (594s left) kms_vblank (ts-continuation-modeset-rpm)
[425.989178] Starting subtest: ts-continuation-modeset-rpm
[425.990280] Starting dynamic subtest: pipe-A-eDP-1
[428.511417] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.521s)
[428.522414] Starting dynamic subtest: pipe-D-eDP-1
[430.694239] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.179s)
[430.695388] Subtest ts-continuation-modeset-rpm: SUCCESS (4.704s)
[431.538264] [084/131] (588s left) kms_atomic_transition (plane-all-transition)
[431.632533] Starting subtest: plane-all-transition
[431.633465] Starting dynamic subtest: pipe-A-eDP-1
[434.137444] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s)
[434.437023] Starting dynamic subtest: pipe-B-eDP-1
[437.648834] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.219s)
[437.926657] Subtest plane-all-transition: SUCCESS (6.292s)
[438.756084] [085/131] (581s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[438.860229] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[442.927975] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.068s)
[444.050040] [086/131] (576s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[444.136966] Starting subtest: plane-upscale-20x20-with-pixel-format
[444.138106] Starting dynamic subtest: pipe-A
[445.187851] Dynamic subtest pipe-A: SUCCESS (1.050s)
[445.197140] Starting dynamic subtest: pipe-B
[447.316207] Dynamic subtest pipe-B: SUCCESS (2.128s)
[447.325571] Starting dynamic subtest: pipe-C
[448.485576] Dynamic subtest pipe-C: SUCCESS (1.169s)
[448.497328] Starting dynamic subtest: pipe-D
[449.681102] Dynamic subtest pipe-D: SUCCESS (1.195s)
[449.682092] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.545s)
[450.836983] [087/131] (569s left) gem_ctx_sseu (invalid-sseu)
[450.893472] Subtest invalid-sseu: SKIP (0.000s)
[450.975617] [088/131] (569s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[451.073692] Starting subtest: 4-tiled-16bpp-rotate-0
[452.495519] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.423s)
[452.724588] [089/131] (567s left) gem_fence_thrash (bo-write-verify-none)
[452.754473] Starting subtest: bo-write-verify-none
[452.781084] Subtest bo-write-verify-none: SKIP (0.024s)
[452.846745] [090/131] (567s left) sw_sync (sync_random_merge)
[452.875958] Starting subtest: sync_random_merge
[452.914837] Subtest sync_random_merge: SUCCESS (0.040s)
[452.973998] [091/131] (567s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[453.063030] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[453.432321] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs
[454.195120] Dynamic subtest pipe-A-eDP-1-4-mc-ccs: SKIP (0.761s)
[454.204676] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[456.462625] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.265s)
[456.474454] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc
[456.747143] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc: SKIP (0.285s)
[456.756857] Starting dynamic subtest: pipe-A-eDP-1-4
[459.017970] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.269s)
[459.027846] Starting dynamic subtest: pipe-A-eDP-1-x
[461.318190] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.299s)
[461.686643] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs
[462.497258] Dynamic subtest pipe-B-eDP-1-4-mc-ccs: SKIP (0.818s)
[462.507087] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[464.764234] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.265s)
[464.774060] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc
[465.039606] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc: SKIP (0.275s)
[465.049100] Starting dynamic subtest: pipe-B-eDP-1-4
[467.331483] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.290s)
[467.341503] Starting dynamic subtest: pipe-B-eDP-1-x
[469.642705] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.310s)
[470.005681] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs
[470.793256] Dynamic subtest pipe-C-eDP-1-4-mc-ccs: SKIP (0.795s)
[470.802964] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[473.061515] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.266s)
[473.072011] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc
[473.336283] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc: SKIP (0.275s)
[473.345425] Starting dynamic subtest: pipe-C-eDP-1-4
[475.639348] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.301s)
[475.651392] Starting dynamic subtest: pipe-C-eDP-1-x
[477.917255] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.277s)
[478.292147] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs
[479.093067] Dynamic subtest pipe-D-eDP-1-4-mc-ccs: SKIP (0.807s)
[479.102445] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[481.360652] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.266s)
[481.371833] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc
[481.636523] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc: SKIP (0.276s)
[481.645779] Starting dynamic subtest: pipe-D-eDP-1-4
[483.917323] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.278s)
[483.928574] Starting dynamic subtest: pipe-D-eDP-1-x
[486.217182] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.299s)
[486.218626] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (33.150s)
[487.435284] [092/131] (532s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt)
[487.524827] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt
[494.340202] Subtest psr-1p-offscren-pri-indfb-draw-blt: SUCCESS (6.815s)
[494.470753] [093/131] (525s left) gem_userptr_blits (probe)
[494.541148] Starting subtest: probe
[494.613832] Subtest probe: SUCCESS (0.072s)
[494.750211] [094/131] (525s left) gem_ctx_persistence (engines-hostile)
[494.806884] Starting subtest: engines-hostile
[494.808145] Starting dynamic subtest: rcs0
[494.977782] Dynamic subtest rcs0: SUCCESS (0.170s)
[494.991061] Starting dynamic subtest: bcs0
[495.080844] Dynamic subtest bcs0: SUCCESS (0.101s)
[495.093091] Starting dynamic subtest: vcs0
[495.198677] Dynamic subtest vcs0: SUCCESS (0.116s)
[495.209599] Starting dynamic subtest: vcs1
[495.327270] Dynamic subtest vcs1: SUCCESS (0.126s)
[495.339629] Starting dynamic subtest: vecs0
[495.456314] Dynamic subtest vecs0: SUCCESS (0.127s)
[495.469712] Starting dynamic subtest: ccs0
[495.536998] Dynamic subtest ccs0: SUCCESS (0.079s)
[495.538628] Subtest engines-hostile: SUCCESS (0.731s)
[495.672676] [095/131] (524s left) kms_rotation_crc (cursor-rotation-180)
[495.767137] Starting subtest: cursor-rotation-180
[497.271336] Subtest cursor-rotation-180: SUCCESS (1.504s)
[498.435488] [096/131] (522s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[503.514619] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[503.517717] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[504.336582] [097/131] (516s left) gem_exec_fence (keep-in-fence)
[504.507837] Starting subtest: keep-in-fence
[504.509358] Starting dynamic subtest: rcs0
[504.589215] Dynamic subtest rcs0: SUCCESS (0.080s)
[504.601585] Starting dynamic subtest: bcs0
[504.643771] Dynamic subtest bcs0: SUCCESS (0.053s)
[504.655479] Starting dynamic subtest: vcs0
[506.061068] Dynamic subtest vcs0: SUCCESS (1.414s)
[506.078165] Starting dynamic subtest: vcs1
[508.044757] Dynamic subtest vcs1: SUCCESS (1.982s)
[508.056624] Starting dynamic subtest: vecs0
[510.092876] Dynamic subtest vecs0: SUCCESS (2.046s)
[510.105316] Starting dynamic subtest: ccs0
[510.323469] Dynamic subtest ccs0: SUCCESS (0.230s)
[510.325035] Subtest keep-in-fence: SUCCESS (5.816s)
[512.177873] [098/131] (508s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[512.280580] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[520.846032] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.565s)
[520.944966] [099/131] (499s left) gem_exec_schedule (wide)
[521.113737] Starting subtest: wide
[521.115191] Starting dynamic subtest: rcs0
[531.731248] Dynamic subtest rcs0: SUCCESS (10.616s)
[531.743795] Starting dynamic subtest: vcs0
[542.173987] Dynamic subtest vcs0: SUCCESS (10.442s)
[542.183292] Starting dynamic subtest: vcs1
[554.031374] Dynamic subtest vcs1: SUCCESS (11.856s)
[554.043967] Starting dynamic subtest: vecs0
[565.136633] Dynamic subtest vecs0: SUCCESS (11.104s)
[565.149333] Starting dynamic subtest: ccs0
[578.608337] Dynamic subtest ccs0: SUCCESS (13.468s)
[578.610138] Subtest wide: SUCCESS (57.490s)
[580.058034] [100/131] (440s left) i915_pm_rpm (sysfs-read)
[582.196738] Starting subtest: sysfs-read
[583.354575] Subtest sysfs-read: SUCCESS (1.157s)
[583.706985] [101/131] (437s left) kms_pm_rpm (universal-planes)
[585.246242] Starting subtest: universal-planes
[585.247535] Starting dynamic subtest: plane-33
[593.573860] Dynamic subtest plane-33: SUCCESS (8.325s)
[593.588101] Starting dynamic subtest: plane-43
[601.890742] Dynamic subtest plane-43: SUCCESS (8.313s)
[601.905116] Starting dynamic subtest: plane-53
[610.597367] Dynamic subtest plane-53: SUCCESS (8.703s)
[610.611135] Starting dynamic subtest: plane-63
[619.289858] Dynamic subtest plane-63: SUCCESS (8.689s)
[619.302883] Starting dynamic subtest: plane-73
[627.667901] Dynamic subtest plane-73: SUCCESS (8.375s)
[627.678489] Starting dynamic subtest: plane-83
[635.947107] Dynamic subtest plane-83: SUCCESS (8.276s)
[635.948840] Subtest universal-planes: SUCCESS (50.698s)
[636.298898] [102/131] (384s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[636.395454] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[636.396334] Starting dynamic subtest: pipe-A-eDP-1
[636.404757] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[636.414271] Starting dynamic subtest: pipe-B-eDP-1
[636.423020] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[636.432275] Starting dynamic subtest: pipe-C-eDP-1
[636.441267] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[636.450197] Starting dynamic subtest: pipe-D-eDP-1
[636.459259] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[636.460938] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[638.627179] [103/131] (382s left) kms_plane_alpha_blend (alpha-opaque-fb)
[638.716853] Starting subtest: alpha-opaque-fb
[639.147583] Starting dynamic subtest: pipe-A-eDP-1
[639.733863] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[639.743178] Starting dynamic subtest: pipe-D-eDP-1
[641.030362] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.295s)
[641.031730] Subtest alpha-opaque-fb: SUCCESS (2.314s)
[641.825175] [104/131] (379s left) gem_fence_thrash (bo-write-verify-threaded-x)
[641.854516] Starting subtest: bo-write-verify-threaded-x
[641.874543] Subtest bo-write-verify-threaded-x: SKIP (0.016s)
[641.929312] [105/131] (378s left) syncobj_timeline (single-wait-for-submit-signaled)
[641.988828] Starting subtest: single-wait-for-submit-signaled
[641.990357] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[642.073320] [106/131] (378s left) perf_pmu (busy-double-start)
[642.105057] Starting subtest: busy-double-start
[642.106030] Starting dynamic subtest: rcs0
[645.702893] Dynamic subtest rcs0: FAIL (3.578s)
[645.712220] Starting dynamic subtest: bcs0
[649.281738] Dynamic subtest bcs0: SUCCESS (3.597s)
[649.294461] Starting dynamic subtest: vcs0
[653.581859] Dynamic subtest vcs0: SUCCESS (4.298s)
[653.593348] Starting dynamic subtest: vcs1
[657.595785] Dynamic subtest vcs1: SUCCESS (4.012s)
[657.607875] Starting dynamic subtest: vecs0
[661.628664] Dynamic subtest vecs0: SUCCESS (4.031s)
[661.641259] Starting dynamic subtest: ccs0
[665.220402] Dynamic subtest ccs0: FAIL (3.563s)
[665.221267] Subtest busy-double-start: FAIL (23.089s)
[665.314700] [107/131] (355s left) sysfs_heartbeat_interval (invalid)
[665.365068] Starting subtest: invalid
[665.366348] Starting dynamic subtest: vecs0
[665.367372] Dynamic subtest vecs0: SUCCESS (0.000s)
[665.377076] Starting dynamic subtest: ccs0
[665.378052] Dynamic subtest ccs0: SUCCESS (0.000s)
[665.387010] Starting dynamic subtest: vcs0
[665.388012] Dynamic subtest vcs0: SUCCESS (0.000s)
[665.396866] Starting dynamic subtest: bcs0
[665.397915] Dynamic subtest bcs0: SUCCESS (0.000s)
[665.407079] Starting dynamic subtest: rcs0
[665.408249] Dynamic subtest rcs0: SUCCESS (0.000s)
[665.418468] Starting dynamic subtest: vcs1
[665.419447] Dynamic subtest vcs1: SUCCESS (0.000s)
[665.420369] Subtest invalid: SUCCESS (0.005s)
[665.463407] [108/131] (355s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[665.550303] Starting subtest: fbcpsr-tiling-linear
[672.045502] Subtest fbcpsr-tiling-linear: SUCCESS (6.496s)
[672.186023] [109/131] (348s left) syncobj_timeline (32bits-limit)
[672.232090] Starting subtest: 32bits-limit
[672.232951] Subtest 32bits-limit: SUCCESS (0.001s)
[672.343069] [110/131] (348s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[672.427177] Starting subtest: bad-aux-stride-y-tiled-ccs
[672.428286] Starting dynamic subtest: pipe-A-eDP-1
[672.439212] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[672.452269] Starting dynamic subtest: pipe-B-eDP-1
[672.461673] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[672.472172] Starting dynamic subtest: pipe-C-eDP-1
[672.480923] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[672.489951] Starting dynamic subtest: pipe-D-eDP-1
[672.498443] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[672.500074] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[674.621909] [111/131] (346s left) kms_properties (crtc-properties-legacy)
[674.715088] Starting subtest: crtc-properties-legacy
[674.716297] Starting dynamic subtest: pipe-A-eDP-1
[675.179991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.463s)
[675.190815] Starting dynamic subtest: pipe-B-eDP-1
[676.365040] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.184s)
[676.375372] Starting dynamic subtest: pipe-C-eDP-1
[677.541415] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.174s)
[677.550262] Starting dynamic subtest: pipe-D-eDP-1
[678.639321] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.097s)
[678.640220] Subtest crtc-properties-legacy: SUCCESS (3.924s)
[679.425749] [112/131] (341s left) gem_mmap_wc (read-write)
[679.469940] Subtest read-write: SKIP (0.000s)
[679.536570] [113/131] (341s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[679.627646] Starting subtest: psr-2p-pri-indfb-multidraw
[679.629250] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[679.737086] [114/131] (341s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt)
[679.823530] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt
[679.825369] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[679.928221] [115/131] (341s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[680.024215] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[680.025822] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[680.115332] [116/131] (341s left) perf (create-destroy-userspace-config)
[680.240487] Starting subtest: create-destroy-userspace-config
[680.264389] Subtest create-destroy-userspace-config: SUCCESS (0.024s)
[680.306086] [117/131] (340s left) kms_feature_discovery (display-4x)
[680.404327] Starting subtest: display-4x
[680.406064] Subtest display-4x: SKIP (0.000s)
[680.470728] [118/131] (340s left) api_intel_bb (object-reloc-purge-cache)
[680.526741] Starting subtest: object-reloc-purge-cache
[680.530827] Subtest object-reloc-purge-cache: SKIP (0.005s)
[680.679270] [119/131] (340s left) kms_plane_multiple (tiling-4)
[680.773133] Starting subtest: tiling-4
[680.774354] Starting dynamic subtest: pipe-A-eDP-1
[684.551128] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.776s)
[684.561127] Starting dynamic subtest: pipe-B-eDP-1
[689.161836] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.609s)
[689.171497] Starting dynamic subtest: pipe-C-eDP-1
[693.737547] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.574s)
[693.747257] Starting dynamic subtest: pipe-D-eDP-1
[698.249458] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.511s)
[698.250423] Subtest tiling-4: SUCCESS (17.475s)
[699.120175] [120/131] (322s left) kms_setmode (basic)
[699.168122] Starting subtest: basic
[699.503400] Starting dynamic subtest: pipe-A-eDP-1
[701.609478] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.103s)
[701.970309] Starting dynamic subtest: pipe-B-eDP-1
[704.012412] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.046s)
[704.317281] Subtest basic: SUCCESS (5.147s)
[705.119366] [121/131] (316s left) api_intel_allocator (execbuf-with-allocator)
[705.170592] Starting subtest: execbuf-with-allocator
[705.173404] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[705.298854] [122/131] (316s left) kms_psr (fbc-psr2-primary-page-flip)
[705.381286] Starting subtest: fbc-psr2-primary-page-flip
[705.382425] Starting dynamic subtest: eDP-1
[705.384223] Dynamic subtest eDP-1: SKIP (0.000s)
[705.385858] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[705.453397] [123/131] (316s left) gem_exec_reloc (basic-write-read-noreloc)
[705.511867] Subtest basic-write-read-noreloc: SKIP (0.000s)
[705.586579] [124/131] (315s left) gem_exec_flush (basic-uc-set-default)
[705.644074] Starting subtest: basic-uc-set-default
[711.091506] Subtest basic-uc-set-default: SUCCESS (5.449s)
[711.271378] [125/131] (310s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[711.324766] Starting subtest: multi-wait-all-for-submit-available-signaled
[711.326144] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[711.438169] [126/131] (310s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[711.482562] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[711.485096] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[711.660936] [127/131] (309s left) kms_psr (psr-sprite-plane-move)
[711.758400] Starting subtest: psr-sprite-plane-move
[711.759600] Starting dynamic subtest: eDP-1
[713.531784] Dynamic subtest eDP-1: SUCCESS (1.772s)
[713.533160] Subtest psr-sprite-plane-move: SUCCESS (1.773s)
[714.317157] [128/131] (307s left) gem_tiled_fence_blits (basic)
[714.376859] Subtest basic: SKIP (0.000s)
[714.443006] [129/131] (307s left) prime_self_import (export-vs-gem_close-race)
[714.471313] Starting subtest: export-vs-gem_close-race
[719.569188] Subtest export-vs-gem_close-race: SUCCESS (5.099s)
[719.640553] [130/131] (302s left) gem_mmap_gtt (hang-user)
[719.691372] Subtest hang-user: SKIP (0.000s)
[719.753894] [131/131] (302s left) kms_flip (2x-modeset-vs-vblank-race)
[719.853194] Starting subtest: 2x-modeset-vs-vblank-race
[719.864026] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[719.939177] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: i915_query
results: parsing output: 2/ for test: intel_hwmon
results: parsing output: 3/ for test: gem_exec_balancer
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: gem_lmem_swapping
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: gem_ctx_persistence
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_ccs
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: gem_workarounds
results: parsing output: 21/ for test: gen7_exec_parse
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: sriov_basic
results: parsing output: 24/ for test: kms_plane_scaling
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: kms_chamelium_audio
results: parsing output: 28/ for test: template
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: kms_chamelium_frames
results: parsing output: 35/ for test: kms_invalid_mode
results: parsing output: 36/ for test: kms_chamelium_hpd
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ctx_param
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: prime_vgem
results: parsing output: 44/ for test: kms_pm_rpm
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: dumb_buffer
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_universal_plane
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: i915_drm_fdinfo
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: gem_partial_pwrite_pread
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_gttfill
results: parsing output: 56/ for test: gem_eio
results: parsing output: 57/ for test: kms_lease
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_force_connector_basic
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: gem_exercise_blt
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: kms_dirtyfb
results: parsing output: 71/ for test: gem_ctx_param
results: parsing output: 72/ for test: kms_color
results: parsing output: 73/ for test: gen9_exec_parse
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_ppgtt
results: parsing output: 78/ for test: i915_pciid
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_vblank
results: parsing output: 83/ for test: kms_atomic_transition
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: gem_ctx_sseu
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_fence_thrash
results: parsing output: 89/ for test: sw_sync
results: parsing output: 90/ for test: kms_async_flips
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: gem_ctx_persistence
results: parsing output: 94/ for test: kms_rotation_crc
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: i915_pm_rpm
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_plane_alpha_blend
results: parsing output: 103/ for test: gem_fence_thrash
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: sysfs_heartbeat_interval
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_properties
results: parsing output: 111/ for test: gem_mmap_wc
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: kms_feature_discovery
results: parsing output: 117/ for test: api_intel_bb
results: parsing output: 118/ for test: kms_plane_multiple
results: parsing output: 119/ for test: kms_setmode
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: gem_exec_flush
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: gem_render_copy
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_tiled_fence_blits
results: parsing output: 128/ for test: prime_self_import
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: kms_flip
Done.