[56.353180] Initializing watchdogs
[56.353286]   /dev/watchdog0
[56.369098] [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]
[56.373904] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.377087] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.380895] [001/133] (960s left) gem_create (create-invalid-size)
[56.453051] Starting subtest: create-invalid-size
[56.455079] Subtest create-invalid-size: SUCCESS (0.000s)
[56.650214] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[56.748650] Starting subtest: fbcpsr-rgb565-draw-pwrite
[63.813997] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.972s)
[63.936348] [003/133] (953s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[63.994074] Starting subtest: single-wait-for-submit-unsubmitted
[64.097277] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[64.184701] [004/133] (952s left) kms_panel_fitting (legacy)
[64.286444] Starting subtest: legacy
[64.288808] Starting dynamic subtest: pipe-A-eDP-1
[64.861160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[64.885077] Starting dynamic subtest: pipe-B-eDP-1
[66.406638] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.517s)
[66.433700] Starting dynamic subtest: pipe-C-eDP-1
[67.934374] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.500s)
[67.958395] Starting dynamic subtest: pipe-D-eDP-1
[69.482896] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.523s)
[69.485470] Subtest legacy: SUCCESS (5.170s)
[70.693356] [005/133] (946s left) kms_cursor_edge_walk (128x128-left-edge)
[70.792977] Starting subtest: 128x128-left-edge
[70.795310] Starting dynamic subtest: pipe-A-eDP-1
[74.260433] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s)
[74.269705] Starting dynamic subtest: pipe-D-eDP-1
[77.395065] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[77.397446] Subtest 128x128-left-edge: SUCCESS (6.589s)
[78.205987] [006/133] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[78.306794] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[78.310838] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[78.425012] [007/133] (938s left) gem_exec_whisper (basic-fds-all)
[78.498247] Starting subtest: basic-fds-all
[90.272770] Subtest basic-fds-all: SUCCESS (11.761s)
[90.450768] [008/133] (926s left) gem_exec_schedule (fairslice-all)
[90.536979] Starting subtest: fairslice-all
[92.657596] Subtest fairslice-all: SUCCESS (2.083s)
[92.922956] [009/133] (924s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[93.010916] Starting subtest: bad-aux-stride-yf-tiled-ccs
[93.013292] Starting dynamic subtest: pipe-A-eDP-1
[93.036035] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[93.045164] Starting dynamic subtest: pipe-B-eDP-1
[93.066510] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[93.074789] Starting dynamic subtest: pipe-C-eDP-1
[93.096190] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[93.103769] Starting dynamic subtest: pipe-D-eDP-1
[93.125480] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[93.129867] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.003s)
[95.255957] [010/133] (921s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[95.354745] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[95.357311] Starting dynamic subtest: pipe-A-eDP-1
[95.381572] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[95.395727] Starting dynamic subtest: pipe-B-eDP-1
[95.418281] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[95.427091] Starting dynamic subtest: pipe-C-eDP-1
[95.449258] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[95.457030] Starting dynamic subtest: pipe-D-eDP-1
[95.478816] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[95.483212] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[97.513176] [011/133] (919s left) gem_create (create-valid-nonaligned)
[97.565873] Starting subtest: create-valid-nonaligned
[97.567851] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[97.751984] [012/133] (919s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[97.868331] Starting subtest: cursorB-vs-flipA-legacy
[97.872941] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[98.015875] [013/133] (919s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[98.131268] Starting subtest: yf-tiled-16bpp-rotate-180
[98.135767] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[98.264210] [014/133] (919s left) i915_pm_rpm (debugfs-forcewake-user)
[100.405411] Starting subtest: debugfs-forcewake-user
[111.788670] Subtest debugfs-forcewake-user: SUCCESS (11.381s)
[112.158483] [015/133] (905s left) gem_softpin (full)
[112.220552] Starting subtest: full
[112.227441] Subtest full: SUCCESS (0.008s)
[112.348462] [016/133] (905s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[112.454755] Starting subtest: 2x-plain-flip-ts-check-interruptible
[112.467035] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.012s)
[112.551432] [017/133] (904s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[112.652083] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[119.783805] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.133s)
[119.886332] [018/133] (897s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[119.949046] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[119.951451] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[120.057880] [019/133] (897s left) gem_ctx_param (invalid-set-no-zeromap)
[120.107712] Starting subtest: invalid-set-no-zeromap
[120.110101] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[120.178448] [020/133] (897s left) kms_sequence (queue-busy)
[120.272516] Starting subtest: queue-busy
[120.274832] Starting dynamic subtest: pipe-A-eDP-1
[122.210713] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s)
[122.220377] Starting dynamic subtest: pipe-B-eDP-1
[124.797212] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.584s)
[124.807411] Starting dynamic subtest: pipe-C-eDP-1
[127.413203] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.614s)
[127.423623] Starting dynamic subtest: pipe-D-eDP-1
[130.030824] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.616s)
[130.032775] Subtest queue-busy: SUCCESS (9.758s)
[130.848918] [021/133] (886s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[130.943134] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[130.968537] Starting dynamic subtest: pipe-A-plane-0
[131.390778] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[131.402514] Starting dynamic subtest: pipe-A-plane-3
[131.660347] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[131.677190] Starting dynamic subtest: pipe-A-plane-5
[131.682097] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[132.725114] Starting dynamic subtest: pipe-B-plane-0
[133.161411] Dynamic subtest pipe-B-plane-0: SUCCESS (0.445s)
[133.170633] Starting dynamic subtest: pipe-B-plane-3
[133.417055] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[133.426579] Starting dynamic subtest: pipe-B-plane-5
[133.431144] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[133.726643] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.783s)
[134.602139] [022/133] (883s left) kms_psr (pr-primary-mmap-cpu)
[134.690643] Starting subtest: pr-primary-mmap-cpu
[134.694855] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[134.782134] [023/133] (883s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[134.875420] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[134.879728] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[134.967386] [024/133] (882s left) gem_exec_reloc (basic-write-gtt-noreloc)
[135.024047] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[135.091627] [025/133] (882s left) gem_workarounds (suspend-resume-fd)
[135.154746] Starting subtest: suspend-resume-fd
[151.142655] Subtest suspend-resume-fd: SUCCESS (2.033s)
[151.299257] [026/133] (866s left) kms_cursor_crc (cursor-offscreen-256x256)
[151.547006] Starting subtest: cursor-offscreen-256x256
[151.554805] Starting dynamic subtest: pipe-A-eDP-1
[153.544796] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.920s)
[153.578241] Starting dynamic subtest: pipe-D-eDP-1
[156.258286] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.619s)
[156.260661] Subtest cursor-offscreen-256x256: SUCCESS (4.570s)
[157.136967] [027/133] (860s left) syncobj_timeline (multi-wait-all-available-signaled)
[157.187691] Starting subtest: multi-wait-all-available-signaled
[157.190169] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[157.281671] [028/133] (860s left) kms_joiner (invalid-modeset-big-joiner)
[157.398515] Starting subtest: invalid-modeset-big-joiner
[157.403024] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[157.470285] [029/133] (860s left) prime_self_import (basic-llseek-bad)
[157.509007] Starting subtest: basic-llseek-bad
[157.526221] Subtest basic-llseek-bad: SUCCESS (0.019s)
[157.629734] [030/133] (860s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[157.717606] Starting subtest: fbc-psr2-sprite-mmap-cpu
[157.720010] Starting dynamic subtest: eDP-1
[157.724548] Dynamic subtest eDP-1: SKIP (0.000s)
[157.728763] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.002s)
[157.792408] [031/133] (860s left) kms_psr (psr-cursor-plane-onoff)
[157.883000] Starting subtest: psr-cursor-plane-onoff
[157.885320] Starting dynamic subtest: eDP-1
[159.670728] Dynamic subtest eDP-1: SUCCESS (1.762s)
[159.673066] Subtest psr-cursor-plane-onoff: SUCCESS (1.763s)
[160.548545] [032/133] (857s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[160.613579] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[160.683019] [033/133] (857s left) kms_flip (flip-vs-rmfb)
[160.780418] Starting subtest: flip-vs-rmfb
[160.785316] Starting dynamic subtest: A-eDP1
[169.488489] Dynamic subtest A-eDP1: SUCCESS (8.640s)
[169.501039] Starting dynamic subtest: B-eDP1
[178.181246] Dynamic subtest B-eDP1: SUCCESS (8.666s)
[178.194275] Starting dynamic subtest: C-eDP1
[186.804072] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[186.816868] Starting dynamic subtest: D-eDP1
[195.440927] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[195.445622] Subtest flip-vs-rmfb: SUCCESS (34.569s)
[196.635079] [034/133] (821s left) gem_eio (kms)
[196.924010] Starting subtest: kms
[215.614114] Subtest kms: SUCCESS (18.683s)
[216.784466] [FACT gem_eio (kms)] new: kernel.kmod_is_loaded.vgem: true
[216.788122] [035/133] (801s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[216.896097] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[216.900570] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[216.994891] [036/133] (801s left) gem_userptr_blits (stress-purge)
[217.056266] Starting subtest: stress-purge
[222.473308] Subtest stress-purge: SUCCESS (5.417s)
[222.623893] [037/133] (795s left) kms_legacy_colorkey (invalid-plane)
[222.772265] Starting subtest: invalid-plane
[222.773859] Starting dynamic subtest: zero-id
[222.775454] Dynamic subtest zero-id: SUCCESS (0.000s)
[222.785845] Starting dynamic subtest: outrange-id
[222.787660] Dynamic subtest outrange-id: SUCCESS (0.000s)
[222.789459] Subtest invalid-plane: SUCCESS (0.001s)
[222.851347] [038/133] (795s left) kms_chamelium_hpd (vga-hpd)
[223.229395] Subtest vga-hpd: SKIP (0.000s)
[224.008939] [039/133] (794s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[224.116806] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[224.120850] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[224.211207] [040/133] (794s left) syncobj_timeline (device-signal-unordered)
[224.271510] Starting subtest: device-signal-unordered
[224.273716] Subtest device-signal-unordered: SUCCESS (0.001s)
[224.348930] [041/133] (794s left) perf_pmu (busy-idle-check-all)
[224.391045] Starting subtest: busy-idle-check-all
[224.393265] Starting dynamic subtest: rcs0
[225.049914] Dynamic subtest rcs0: SUCCESS (0.659s)
[225.065767] Starting dynamic subtest: bcs0
[225.704612] Dynamic subtest bcs0: SUCCESS (0.651s)
[225.720970] Starting dynamic subtest: vcs0
[227.262737] Dynamic subtest vcs0: SUCCESS (1.553s)
[227.275828] Starting dynamic subtest: vcs1
[229.247058] Dynamic subtest vcs1: SUCCESS (1.980s)
[229.261365] Starting dynamic subtest: vecs0
[231.230676] Dynamic subtest vecs0: SUCCESS (1.980s)
[231.244962] Starting dynamic subtest: ccs0
[231.888688] Dynamic subtest ccs0: SUCCESS (0.656s)
[231.891243] Subtest busy-idle-check-all: SUCCESS (7.496s)
[231.996058] [042/133] (786s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[232.106193] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[236.183366] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.078s)
[237.344896] [043/133] (781s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[237.442464] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[237.444751] Starting dynamic subtest: pipe-A-eDP-1
[237.453525] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[237.465462] Starting dynamic subtest: pipe-B-eDP-1
[237.474215] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[237.484553] Starting dynamic subtest: pipe-C-eDP-1
[237.493039] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[237.503248] Starting dynamic subtest: pipe-D-eDP-1
[237.511526] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[237.515737] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[239.697354] [044/133] (778s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[239.808276] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[240.500000] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[240.672298] [045/133] (778s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[240.794557] Starting subtest: short-flip-after-cursor-toggle
[241.708071] Subtest short-flip-after-cursor-toggle: SUCCESS (0.913s)
[242.532080] [046/133] (776s left) core_getversion (all-cards)
[242.568794] Starting subtest: all-cards
[242.575973] Subtest all-cards: SUCCESS (0.011s)
[242.630238] [047/133] (776s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[242.687268] Starting subtest: y-tiled-to-vebox-yf-tiled
[242.691395] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[242.884143] [048/133] (775s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[242.987566] Starting subtest: psr2-overlay-plane-update-continuous-sf
[242.989938] Starting dynamic subtest: pipe-A-eDP-1
[244.103313] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.118s)
[244.113931] Starting dynamic subtest: pipe-B-eDP-1
[245.880257] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.776s)
[245.882415] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.897s)
[246.691219] [049/133] (772s left) kms_dp_aux_dev (basic)
[246.747292] Starting subtest: basic
[246.969341] Subtest basic: SUCCESS (0.222s)
[247.055857] [050/133] (771s left) gem_exec_schedule (noreorder-priority)
[247.242589] Starting subtest: noreorder-priority
[247.244912] Starting dynamic subtest: rcs0
[248.377048] Dynamic subtest rcs0: SUCCESS (1.134s)
[248.391023] Starting dynamic subtest: vcs0
[250.234793] Dynamic subtest vcs0: SUCCESS (1.855s)
[250.247857] Starting dynamic subtest: vcs1
[252.198235] Dynamic subtest vcs1: SUCCESS (1.961s)
[252.211225] Starting dynamic subtest: vecs0
[254.271567] Dynamic subtest vecs0: SUCCESS (2.072s)
[254.285179] Starting dynamic subtest: ccs0
[255.410261] Dynamic subtest ccs0: SUCCESS (1.138s)
[255.413207] Subtest noreorder-priority: SUCCESS (8.172s)
[255.601993] [051/133] (763s left) kms_scaling_modes (scaling-mode-center)
[255.698985] Starting subtest: scaling-mode-center
[255.701131] Starting dynamic subtest: pipe-A-eDP-1
[255.791405] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[255.805229] Starting dynamic subtest: pipe-B-eDP-1
[256.920097] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.125s)
[256.934689] Starting dynamic subtest: pipe-C-eDP-1
[258.026935] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.103s)
[258.040954] Starting dynamic subtest: pipe-D-eDP-1
[259.150282] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[259.152728] Subtest scaling-mode-center: SUCCESS (3.455s)
[260.301061] [052/133] (758s left) kms_rotation_crc (primary-rotation-270)
[260.398474] Starting subtest: primary-rotation-270
[260.402823] Subtest primary-rotation-270: SKIP (0.001s)
[260.470784] [053/133] (758s left) gem_softpin (softpin)
[260.533649] Starting subtest: softpin
[292.866150] Subtest softpin: SUCCESS (32.327s)
[292.991849] [054/133] (726s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[293.103724] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[293.107885] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[293.179674] [055/133] (725s left) kms_content_protection (uevent-hdcp14)
[293.319035] Starting subtest: uevent-hdcp14
[293.323590] Subtest uevent-hdcp14: SKIP (0.000s)
[293.429055] [056/133] (725s left) perf_pmu (frequency)
[293.482954] Starting subtest: frequency
[293.485111] Starting dynamic subtest: gt0
[295.622831] Dynamic subtest gt0: SUCCESS (2.133s)
[295.635519] Starting dynamic subtest: idle-gt0
[296.129152] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[296.139981] Starting dynamic subtest: gt1
[300.229377] Dynamic subtest gt1: SUCCESS (4.094s)
[300.241742] Starting dynamic subtest: idle-gt1
[300.733879] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[300.736529] Subtest frequency: SUCCESS (7.253s)
[300.839697] [057/133] (718s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[300.944460] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[300.948771] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[301.051458] [058/133] (718s left) api_intel_allocator (standalone)
[301.114735] Starting subtest: standalone
[301.128901] Subtest standalone: SUCCESS (0.017s)
[301.253455] [059/133] (718s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[301.355404] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[301.359766] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[301.469165] [060/133] (717s left) gem_create (hog-create)
[301.535150] Starting subtest: hog-create
[301.537464] Starting dynamic subtest: smem0
[335.222430] Dynamic subtest smem0: SUCCESS (33.676s)
[335.225077] Subtest hog-create: SUCCESS (33.678s)
[335.411129] [061/133] (683s left) gem_exec_schedule (u-lateslice)
[335.477098] Starting subtest: u-lateslice
[335.479559] Starting dynamic subtest: rcs0
[335.494048] Dynamic subtest rcs0: SUCCESS (0.027s)
[335.506775] Starting dynamic subtest: bcs0
[335.517050] Dynamic subtest bcs0: SUCCESS (0.022s)
[335.529413] Starting dynamic subtest: vcs0
[335.539001] Dynamic subtest vcs0: SUCCESS (0.021s)
[335.549653] Starting dynamic subtest: vcs1
[335.563228] Dynamic subtest vcs1: SUCCESS (0.023s)
[335.573844] Starting dynamic subtest: vecs0
[335.589725] Dynamic subtest vecs0: SUCCESS (0.026s)
[335.600481] Starting dynamic subtest: ccs0
[335.614626] Dynamic subtest ccs0: SUCCESS (0.024s)
[335.617018] Subtest u-lateslice: SUCCESS (0.148s)
[337.370227] [062/133] (682s left) prime_busy (after)
[337.456794] Starting subtest: after
[337.458703] Starting dynamic subtest: rcs0
[337.489596] Dynamic subtest rcs0: SUCCESS (0.030s)
[337.500377] Starting dynamic subtest: bcs0
[337.528564] Dynamic subtest bcs0: SUCCESS (0.038s)
[337.539476] Starting dynamic subtest: vcs0
[337.569810] Dynamic subtest vcs0: SUCCESS (0.040s)
[337.580379] Starting dynamic subtest: vcs1
[337.612226] Dynamic subtest vcs1: SUCCESS (0.042s)
[337.622376] Starting dynamic subtest: vecs0
[337.655925] Dynamic subtest vecs0: SUCCESS (0.042s)
[337.667103] Starting dynamic subtest: ccs0
[337.698660] Dynamic subtest ccs0: SUCCESS (0.042s)
[337.808219] Subtest after: SUCCESS (0.352s)
[337.890621] [063/133] (681s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[338.005575] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[338.009543] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[338.107139] [064/133] (681s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[338.225174] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[338.229308] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[338.332734] [065/133] (681s left) kms_feature_discovery (display-1x)
[338.430027] Starting subtest: display-1x
[338.432289] Subtest display-1x: SUCCESS (0.000s)
[338.505926] [066/133] (681s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[338.600248] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[338.602542] Starting dynamic subtest: pipe-A
[338.622576] Dynamic subtest pipe-A: SKIP (0.018s)
[338.633828] Starting dynamic subtest: pipe-B
[338.653865] Dynamic subtest pipe-B: SKIP (0.031s)
[338.664506] Starting dynamic subtest: pipe-C
[338.685133] Dynamic subtest pipe-C: SKIP (0.031s)
[338.695605] Starting dynamic subtest: pipe-D
[338.716566] Dynamic subtest pipe-D: SKIP (0.031s)
[338.720674] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.114s)
[338.842256] [067/133] (680s left) syncobj_wait (single-wait-for-submit-signaled)
[338.902606] Starting subtest: single-wait-for-submit-signaled
[338.904273] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[339.026162] [068/133] (680s left) kms_pm_lpsp (kms-lpsp)
[340.136221] Starting subtest: kms-lpsp
[340.138395] Starting dynamic subtest: pipe-A-eDP-1
[340.285933] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.153s)
[340.587512] Subtest kms-lpsp: SUCCESS (0.455s)
[341.456335] [069/133] (678s left) kms_plane (pixel-format-y-tiled-modifier)
[341.568586] Starting subtest: pixel-format-y-tiled-modifier
[341.573076] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[341.655431] [070/133] (678s left) kms_mmap_write_crc (main)
[341.746770] Starting subtest: main
[341.748998] Starting dynamic subtest: pipe-A-eDP-1
[345.261797] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.512s)
[345.264000] Subtest main: SUCCESS (3.513s)
[346.095165] [071/133] (673s left) gem_lmem_swapping (heavy-verify-multi)
[346.140599] Subtest heavy-verify-multi: SKIP (0.000s)
[346.189598] [072/133] (673s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[346.335490] Starting subtest: cursor-rapid-movement-32x32
[346.387960] Subtest cursor-rapid-movement-32x32: SKIP (0.048s)
[346.679301] [073/133] (673s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[346.775645] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[346.779688] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[346.892517] [074/133] (673s left) kms_rotation_crc (bad-tiling)
[346.982362] Starting subtest: bad-tiling
[346.986570] Subtest bad-tiling: SKIP (0.001s)
[347.055382] [075/133] (672s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[347.150686] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[347.154715] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[347.260046] [076/133] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[347.356431] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[347.359975] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[347.459649] [077/133] (672s left) syncobj_wait (wait-all-snapshot)
[347.508330] Starting subtest: wait-all-snapshot
[347.589216] Subtest wait-all-snapshot: SUCCESS (0.081s)
[347.674866] [078/133] (672s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[347.771171] Starting subtest: x-tiled-8bpp-rotate-0
[349.006393] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.236s)
[349.140531] [079/133] (671s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[349.225661] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[349.227679] Starting dynamic subtest: pipe-A-eDP-1
[349.246866] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[349.258681] Starting dynamic subtest: pipe-B-eDP-1
[349.276660] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[349.286707] Starting dynamic subtest: pipe-C-eDP-1
[349.304944] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[349.317104] Starting dynamic subtest: pipe-D-eDP-1
[349.336700] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[349.340227] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[351.529513] [080/133] (668s left) kms_prime (basic-modeset-hybrid)
[351.618423] Subtest basic-modeset-hybrid: SKIP (0.000s)
[351.739579] [081/133] (668s left) kms_addfb_basic (basic-x-tiled-legacy)
[351.801237] Starting subtest: basic-x-tiled-legacy
[351.805668] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[351.928151] [082/133] (668s left) perf (gen12-invalid-class-instance)
[352.076830] Starting subtest: gen12-invalid-class-instance
[352.087091] Subtest gen12-invalid-class-instance: SUCCESS (0.010s)
[352.162719] [083/133] (668s left) gem_set_tiling_vs_gtt
[352.305572] [084/133] (668s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[352.364478] Starting subtest: invalid-bsd2-flag-on-vebox
[352.366770] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[352.499743] [085/133] (668s left) syncobj_timeline (wait-all-delayed-signal)
[352.566068] Starting subtest: wait-all-delayed-signal
[352.667727] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[352.758723] [086/133] (667s left) i915_pciid
[352.908301] [087/133] (667s left) gem_exec_balancer (individual)
[352.975291] Starting subtest: individual
[354.233565] Subtest individual: SUCCESS (1.257s)
[354.568118] [088/133] (666s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[354.679078] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[354.683449] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[354.755429] [089/133] (665s left) kms_chamelium_audio (dp-audio-edid)
[355.132610] Subtest dp-audio-edid: SKIP (0.000s)
[355.941065] [090/133] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[356.038509] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[356.042604] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[356.122795] [091/133] (664s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[356.218746] Starting subtest: fbc-1p-pri-indfb-multidraw
[369.327398] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.108s)
[370.692235] [092/133] (650s left) gem_exec_params (sol-reset-invalid)
[370.759082] Starting subtest: sol-reset-invalid
[370.761357] Subtest sol-reset-invalid: SUCCESS (0.002s)
[372.345914] [093/133] (648s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[372.416884] Starting subtest: invalid-multi-wait-all-unsubmitted
[372.419255] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[372.534670] [094/133] (648s left) gem_exec_flush (basic-batch-kernel-default-uc)
[372.598338] Starting subtest: basic-batch-kernel-default-uc
[378.927782] Subtest basic-batch-kernel-default-uc: SUCCESS (6.331s)
[379.122157] [095/133] (641s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[379.231086] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[379.233656] Starting dynamic subtest: pipe-A-eDP-1
[379.305021] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[379.316549] Starting dynamic subtest: pipe-B-eDP-1
[380.454217] Dynamic subtest pipe-B-eDP-1: SKIP (1.146s)
[380.458315] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.228s)
[381.644707] [096/133] (639s left) gem_mmap_gtt (basic-read-write)
[381.709331] Subtest basic-read-write: SKIP (0.000s)
[381.780618] [097/133] (639s left) gem_pxp (verify-pxp-stale-buf-execution)
[381.901996] Starting subtest: verify-pxp-stale-buf-execution
[382.958917] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.060s)
[383.077484] [098/133] (637s left) kms_hdr (brightness-with-hdr)
[383.182360] Starting subtest: brightness-with-hdr
[383.188983] Subtest brightness-with-hdr: SKIP (0.000s)
[383.267896] [099/133] (637s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[383.371689] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[389.962620] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.597s)
[390.101129] [100/133] (631s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[390.210077] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[394.419079] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.213s)
[395.603299] [101/133] (625s left) kms_psr (fbc-psr2-sprite-blt)
[395.694123] Starting subtest: fbc-psr2-sprite-blt
[395.696421] Starting dynamic subtest: eDP-1
[395.700808] Dynamic subtest eDP-1: SKIP (0.000s)
[395.704837] Subtest fbc-psr2-sprite-blt: SKIP (0.002s)
[395.775504] [102/133] (625s left) gem_exec_params (batch-first)
[395.830842] Starting subtest: batch-first
[395.836420] Subtest batch-first: SUCCESS (0.006s)
[395.955637] [103/133] (625s left) kms_chamelium_frames (hdmi-crc-multiple)
[396.341925] Subtest hdmi-crc-multiple: SKIP (0.000s)
[397.178668] [104/133] (624s left) gem_partial_pwrite_pread (reads-uncached)
[397.247037] Subtest reads-uncached: SKIP (0.000s)
[397.342288] [105/133] (624s left) syncobj_wait (wait-all-delayed-signal)
[397.394690] Starting subtest: wait-all-delayed-signal
[397.495557] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[397.602105] [106/133] (623s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[397.692311] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[397.696397] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[397.812344] [107/133] (623s left) i915_suspend (basic-s3-without-i915)
[397.849320] Starting subtest: basic-s3-without-i915
[401.146310] Subtest basic-s3-without-i915: SKIP (3.294s)
[402.740622] [108/133] (618s left) gem_exec_fence (nb-await)
[402.931444] Starting subtest: nb-await
[402.934062] Starting dynamic subtest: rcs0
[403.007354] Dynamic subtest rcs0: SUCCESS (0.075s)
[403.018157] Starting dynamic subtest: bcs0
[403.065492] Dynamic subtest bcs0: SUCCESS (0.057s)
[403.078150] Starting dynamic subtest: vcs0
[403.125075] Dynamic subtest vcs0: SUCCESS (0.057s)
[403.137382] Starting dynamic subtest: vcs1
[403.185257] Dynamic subtest vcs1: SUCCESS (0.057s)
[403.197244] Starting dynamic subtest: vecs0
[403.244963] Dynamic subtest vecs0: SUCCESS (0.057s)
[403.257344] Starting dynamic subtest: ccs0
[403.304222] Dynamic subtest ccs0: SUCCESS (0.057s)
[403.307131] Subtest nb-await: SUCCESS (0.374s)
[405.336890] [109/133] (616s left) i915_drm_fdinfo (context-close-stress)
[405.381220] Starting subtest: context-close-stress
[416.178667] Subtest context-close-stress: SUCCESS (10.745s)
[416.242125] [110/133] (605s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[416.482300] Starting subtest: y-tiled-32bpp-rotate-270
[416.486721] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[416.583501] [111/133] (605s left) gem_pxp (fail-invalid-protected-context)
[416.721515] Starting subtest: fail-invalid-protected-context
[416.724014] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[416.851033] [112/133] (604s left) core_auth (many-magics)
[416.921510] Starting subtest: many-magics
[417.711013] Subtest many-magics: SUCCESS (0.790s)
[417.834636] [113/133] (603s left) gem_ctx_persistence (process)
[417.894817] Starting subtest: process
[418.072493] Subtest process: SUCCESS (0.177s)
[418.154130] [114/133] (603s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[418.243012] Starting subtest: fbcpsr-tiling-4
[425.332731] Subtest fbcpsr-tiling-4: SUCCESS (7.093s)
[425.471349] [115/133] (596s left) gem_mmap_offset (basic-uaf)
[425.524923] Starting subtest: basic-uaf
[425.527330] Subtest basic-uaf: SUCCESS (0.001s)
[425.622690] [116/133] (596s left) gem_basic (multigpu-create-close)
[425.682996] Starting subtest: multigpu-create-close
[425.686997] Subtest multigpu-create-close: SKIP (0.000s)
[425.774897] [117/133] (596s left) syncobj_timeline (multi-wait-signaled)
[425.826904] Starting subtest: multi-wait-signaled
[425.829194] Subtest multi-wait-signaled: SUCCESS (0.000s)
[425.914966] [118/133] (596s left) kms_vblank (ts-continuation-modeset)
[426.004472] Starting subtest: ts-continuation-modeset
[426.006342] Starting dynamic subtest: pipe-A-eDP-1
[427.508025] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.503s)
[427.525342] Starting dynamic subtest: pipe-D-eDP-1
[429.669905] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.159s)
[429.671846] Subtest ts-continuation-modeset: SUCCESS (3.665s)
[430.465063] [119/133] (591s left) kms_color (ctm-0-25)
[430.553443] Starting subtest: ctm-0-25
[430.555685] Starting dynamic subtest: pipe-A-eDP-1
[433.978290] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.425s)
[433.992015] Starting dynamic subtest: pipe-B-eDP-1
[438.194737] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.216s)
[438.206410] Starting dynamic subtest: pipe-C-eDP-1
[442.244647] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.047s)
[442.254948] Starting dynamic subtest: pipe-D-eDP-1
[446.265568] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.019s)
[446.267857] Subtest ctm-0-25: SUCCESS (15.711s)
[447.082004] [120/133] (574s left) drm_read (invalid-buffer)
[447.236403] Starting subtest: invalid-buffer
[447.238754] Subtest invalid-buffer: SUCCESS (0.000s)
[447.368388] [121/133] (574s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[447.459247] Starting subtest: plane-primary-toggle-with-vblank-wait
[447.461391] Starting dynamic subtest: pipe-A-eDP-1
[447.632333] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[447.953977] Starting dynamic subtest: pipe-B-eDP-1
[448.882921] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.941s)
[449.179568] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.722s)
[450.033429] [122/133] (572s left) kms_big_fb (linear-32bpp-rotate-270)
[450.138406] Starting subtest: linear-32bpp-rotate-270
[450.158910] Subtest linear-32bpp-rotate-270: SKIP (0.020s)
[450.266754] [123/133] (571s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[450.351401] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[450.355387] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[450.428976] [124/133] (571s left) api_intel_bb (purge-bb)
[450.492093] Starting subtest: purge-bb
[450.497102] Subtest purge-bb: SUCCESS (0.007s)
[450.611742] [125/133] (571s left) gem_exec_reloc (basic-wc-gtt-active)
[450.668921] Subtest basic-wc-gtt-active: SKIP (0.000s)
[450.733068] [126/133] (571s left) gem_lmem_swapping (verify-ccs)
[450.773491] Subtest verify-ccs: SKIP (0.000s)
[450.824009] [127/133] (571s left) kms_atomic_interruptible (legacy-cursor)
[450.927354] Starting subtest: legacy-cursor
[450.929637] Starting dynamic subtest: pipe-A-eDP-1
[458.343840] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.415s)
[458.346329] Subtest legacy-cursor: SUCCESS (7.417s)
[459.210771] [128/133] (563s left) gen9_exec_parse (bb-oversize)
[459.270079] Subtest bb-oversize: SKIP (0.000s)
[459.347120] [129/133] (563s left) perf (missing-sample-flags)
[459.464947] Starting subtest: missing-sample-flags
[459.467242] Subtest missing-sample-flags: SUCCESS (0.000s)
[459.513074] [130/133] (562s left) sysfs_heartbeat_interval (precise)
[459.575901] Starting subtest: precise
[459.578251] Starting dynamic subtest: vecs0
[467.260430] Dynamic subtest vecs0: SUCCESS (7.681s)
[467.272800] Starting dynamic subtest: ccs0
[468.404124] Dynamic subtest ccs0: SUCCESS (1.141s)
[468.416894] Starting dynamic subtest: vcs0
[475.261427] Dynamic subtest vcs0: SUCCESS (6.857s)
[475.272932] Starting dynamic subtest: bcs0
[476.387692] Dynamic subtest bcs0: SUCCESS (1.123s)
[476.400127] Starting dynamic subtest: rcs0
[477.531882] Dynamic subtest rcs0: SUCCESS (1.142s)
[477.542939] Starting dynamic subtest: vcs1
[485.245164] Dynamic subtest vcs1: SUCCESS (7.708s)
[485.247759] Subtest precise: SUCCESS (25.664s)
[485.338668] [131/133] (537s left) gem_exec_balancer (parallel-keep-submit-fence)
[485.618915] Starting subtest: parallel-keep-submit-fence
[486.736031] Subtest parallel-keep-submit-fence: SUCCESS (1.117s)
[486.864123] [132/133] (535s left) kms_async_flips (crc-atomic)
[486.963260] Starting subtest: crc-atomic
[487.335371] Starting dynamic subtest: pipe-A-eDP-1
[490.236443] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.880s)
[490.616889] Starting dynamic subtest: pipe-B-eDP-1
[493.562743] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.939s)
[493.925883] Starting dynamic subtest: pipe-C-eDP-1
[496.802667] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.854s)
[497.136488] Starting dynamic subtest: pipe-D-eDP-1
[500.042075] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.883s)
[500.044795] Subtest crc-atomic: SUCCESS (13.047s)
[501.184967] [133/133] (521s left) kms_plane_multiple (tiling-4)
[501.284147] Starting subtest: tiling-4
[501.286506] Starting dynamic subtest: pipe-A-eDP-1
[505.017977] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.732s)
[505.030406] Starting dynamic subtest: pipe-B-eDP-1
[509.460821] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.443s)
[509.471911] Starting dynamic subtest: pipe-C-eDP-1
[513.863019] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.398s)
[513.873641] Starting dynamic subtest: pipe-D-eDP-1
[518.219691] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.353s)
[518.222264] Subtest tiling-4: SUCCESS (16.932s)
[519.025280] Closing watchdogs
results: parsing output: 0/ for test: gem_create
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: kms_panel_fitting
results: parsing output: 4/ for test: kms_cursor_edge_walk
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: gem_create
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: i915_pm_rpm
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_sequence
results: parsing output: 20/ for test: kms_plane
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: gem_workarounds
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_joiner
results: parsing output: 28/ for test: prime_self_import
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_legacy_colorkey
results: parsing output: 37/ for test: kms_chamelium_hpd
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: core_getversion
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: kms_dp_aux_dev
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_scaling_modes
results: parsing output: 51/ for test: kms_rotation_crc
results: parsing output: 52/ for test: gem_softpin
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_content_protection
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: api_intel_allocator
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_create
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: prime_busy
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_feature_discovery
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: kms_pm_lpsp
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_mmap_write_crc
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_prime
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: gem_set_tiling_vs_gtt
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: i915_pciid
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: kms_chamelium_audio
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: gem_exec_flush
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: gem_pxp
results: parsing output: 97/ for test: kms_hdr
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: kms_chamelium_frames
results: parsing output: 103/ for test: gem_partial_pwrite_pread
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: i915_suspend
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_pxp
results: parsing output: 111/ for test: core_auth
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_mmap_offset
results: parsing output: 115/ for test: gem_basic
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_vblank
results: parsing output: 118/ for test: kms_color
results: parsing output: 119/ for test: drm_read
results: parsing output: 120/ for test: kms_atomic_transition
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: api_intel_bb
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: gem_lmem_swapping
results: parsing output: 126/ for test: kms_atomic_interruptible
results: parsing output: 127/ for test: gen9_exec_parse
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: sysfs_heartbeat_interval
results: parsing output: 130/ for test: gem_exec_balancer
results: parsing output: 131/ for test: kms_async_flips
results: parsing output: 132/ for test: kms_plane_multiple
Done.