[60.368044] Initializing watchdogs
[60.368095]   /dev/watchdog0
[60.383337] [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]
[60.387884] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.390210] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.393481] [001/133] (960s left) kms_async_flips (invalid-async-flip-atomic)
[60.509790] Starting subtest: invalid-async-flip-atomic
[60.893499] Starting dynamic subtest: pipe-A-eDP-1
[61.704706] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.810s)
[62.067337] Starting dynamic subtest: pipe-B-eDP-1
[62.847859] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.785s)
[63.207255] Starting dynamic subtest: pipe-C-eDP-1
[63.976538] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.774s)
[64.336417] Starting dynamic subtest: pipe-D-eDP-1
[65.108893] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s)
[65.111353] Subtest invalid-async-flip-atomic: SUCCESS (4.596s)
[66.277977] [002/133] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[66.381463] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[66.385643] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[66.470021] [003/133] (954s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[66.707623] Starting subtest: cursor-rapid-movement-256x256
[66.712233] Starting dynamic subtest: pipe-A-eDP-1
[67.306511] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.595s)
[67.335514] Starting dynamic subtest: pipe-D-eDP-1
[68.577731] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[68.580148] Subtest cursor-rapid-movement-256x256: SUCCESS (1.869s)
[69.418798] [004/133] (951s left) gem_exercise_blt (fast-copy-emit)
[69.486813] Starting subtest: fast-copy-emit
[69.489237] Starting dynamic subtest: linear-smem-smem-emit
[69.510469] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s)
[69.519255] Starting dynamic subtest: xmajor-smem-smem-emit
[69.528421] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.018s)
[69.535238] Starting dynamic subtest: tile4-smem-smem-emit
[69.546328] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[69.553128] Starting dynamic subtest: tile64-smem-smem-emit
[69.562826] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[69.565109] Subtest fast-copy-emit: SUCCESS (0.076s)
[69.683714] [005/133] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[69.782608] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[76.462772] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.680s)
[76.609986] [006/133] (944s left) gem_exec_flush (basic-wb-rw-before-default)
[76.681035] Starting subtest: basic-wb-rw-before-default
[82.135751] Subtest basic-wb-rw-before-default: SUCCESS (5.454s)
[82.320199] [007/133] (938s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[82.424067] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[82.436351] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[82.506642] [008/133] (938s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[82.621093] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[82.625110] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[82.699562] [009/133] (938s left) tools_test (tools_test)
[82.752484] Starting subtest: tools_test
[82.802828] Subtest tools_test: SUCCESS (0.064s)
[82.865719] [010/133] (938s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[82.925265] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[83.032957] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[83.118183] [011/133] (938s left) kms_big_fb (linear-32bpp-rotate-180)
[83.228378] Starting subtest: linear-32bpp-rotate-180
[84.664024] Subtest linear-32bpp-rotate-180: SUCCESS (1.437s)
[84.801136] [012/133] (936s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[84.923899] Starting subtest: 2x-cursor-vs-flip-atomic
[84.927421] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[85.082441] [013/133] (936s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[85.167047] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[85.193619] Starting dynamic subtest: pipe-A-plane-0
[85.838128] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s)
[85.846211] Starting dynamic subtest: pipe-A-plane-3
[86.260290] Dynamic subtest pipe-A-plane-3: SUCCESS (0.422s)
[87.364962] Starting dynamic subtest: pipe-B-plane-0
[88.013590] Dynamic subtest pipe-B-plane-0: SUCCESS (0.656s)
[88.025433] Starting dynamic subtest: pipe-B-plane-3
[88.435205] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s)
[88.763178] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.595s)
[89.558362] [014/133] (931s left) i915_fb_tiling (basic-x-tiling)
[89.616037] Subtest basic-x-tiling: SKIP (0.000s)
[89.667177] [015/133] (931s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[89.753168] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[89.755532] Starting dynamic subtest: pipe-A-default-mode
[92.499252] Dynamic subtest pipe-A-default-mode: SUCCESS (2.747s)
[92.501563] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.748s)
[93.359771] [016/133] (928s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[95.093621] Starting subtest: modeset-lpsp-stress-no-wait
[105.172320] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.078s)
[105.246062] [017/133] (916s left) kms_hdr (bpc-switch-suspend)
[105.342918] Starting subtest: bpc-switch-suspend
[106.401222] Starting dynamic subtest: pipe-A-eDP-1
[126.192688] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.026s)
[126.195075] Subtest bpc-switch-suspend: SUCCESS (6.088s)
[137.325014] [018/133] (895s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[137.450473] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[137.452693] Starting dynamic subtest: pipe-A-eDP-1
[137.474517] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[137.484483] Starting dynamic subtest: pipe-B-eDP-1
[137.504873] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[137.512669] Starting dynamic subtest: pipe-C-eDP-1
[137.533302] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[137.540602] Starting dynamic subtest: pipe-D-eDP-1
[137.561900] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[137.566200] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[139.723735] [019/133] (892s left) kms_pm_backlight (fade)
[139.822733] Starting subtest: fade
[139.873714] Starting dynamic subtest: eDP-1
[142.393820] Dynamic subtest eDP-1: SUCCESS (2.497s)
[142.396165] Subtest fade: SUCCESS (2.550s)
[143.194461] [020/133] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[143.312274] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[143.316316] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[143.420480] [021/133] (889s left) kms_pipe_crc_basic (suspend-read-crc)
[143.512830] Starting subtest: suspend-read-crc
[143.515202] Starting dynamic subtest: pipe-A-eDP-1
[161.979522] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.959s)
[161.989407] Starting dynamic subtest: pipe-B-eDP-1
[180.982716] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.585s)
[180.991666] Starting dynamic subtest: pipe-C-eDP-1
[199.937450] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.487s)
[199.948309] Starting dynamic subtest: pipe-D-eDP-1
[218.937671] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.456s)
[218.939916] Subtest suspend-read-crc: SUCCESS (13.494s)
[230.775085] [022/133] (812s left) api_intel_allocator (reloc-allocator)
[230.850765] Starting subtest: reloc-allocator
[230.853238] Starting dynamic subtest: basic
[230.855665] Dynamic subtest basic: SUCCESS (0.006s)
[230.866764] Starting dynamic subtest: parallel-one
[230.868677] Dynamic subtest parallel-one: SUCCESS (0.008s)
[230.880843] Starting dynamic subtest: print
[230.883242] Dynamic subtest print: SUCCESS (0.000s)
[230.893738] Starting dynamic subtest: reuse
[230.898033] Dynamic subtest reuse: SUCCESS (0.000s)
[230.906058] Starting dynamic subtest: fork-reopen-allocator
[230.907995] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[230.909910] Subtest reloc-allocator: SUCCESS (0.031s)
[231.012599] [023/133] (812s left) kms_dirtyfb (default-dirtyfb-ioctl)
[231.114608] Starting subtest: default-dirtyfb-ioctl
[231.116580] Starting dynamic subtest: A-eDP-1
[232.720875] Dynamic subtest A-eDP-1: SUCCESS (1.592s)
[232.723318] Subtest default-dirtyfb-ioctl: SUCCESS (1.593s)
[233.522503] [024/133] (810s left) kms_cursor_crc (cursor-onscreen-64x64)
[233.681469] Starting subtest: cursor-onscreen-64x64
[233.686443] Starting dynamic subtest: pipe-A-eDP-1
[235.800438] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.099s)
[235.829329] Starting dynamic subtest: pipe-D-eDP-1
[238.651478] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.815s)
[238.653898] Subtest cursor-onscreen-64x64: SUCCESS (4.940s)
[239.513348] [025/133] (804s left) gem_exec_fence (submit)
[239.698736] Starting subtest: submit
[239.703572] Subtest submit: SKIP (0.000s)
[241.609356] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[241.613462] [026/133] (802s left) gem_mmap_gtt (flink-race)
[241.669383] Subtest flink-race: SKIP (0.000s)
[241.732849] [027/133] (802s left) gem_compute (compute-square)
[241.779654] Starting subtest: compute-square
[241.785396] Subtest compute-square: SUCCESS (0.007s)
[241.895981] [028/133] (802s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[242.040289] Starting subtest: dp-mst-type-0-suspend-resume
[242.044922] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[242.165532] [029/133] (801s left) gem_exec_balancer (invalid-bonds)
[242.240146] Starting subtest: invalid-bonds
[242.244719] Subtest invalid-bonds: SKIP (0.000s)
[242.540981] [030/133] (801s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[242.635030] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[242.639387] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[242.720346] [031/133] (801s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[242.818429] Starting subtest: psr-rgb565-draw-blt
[249.839649] Subtest psr-rgb565-draw-blt: SUCCESS (7.011s)
[249.969523] [032/133] (794s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[250.025916] Starting subtest: invalid-single-wait-all-unsubmitted
[250.028085] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[250.147258] [033/133] (794s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[250.248065] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[250.257247] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[250.340295] [034/133] (793s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[250.432553] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[250.434721] Starting dynamic subtest: pipe-A-eDP-1
[250.937701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.483s)
[250.946653] Starting dynamic subtest: pipe-B-eDP-1
[252.405980] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.459s)
[252.416540] Starting dynamic subtest: pipe-C-eDP-1
[253.788654] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[253.797232] Starting dynamic subtest: pipe-D-eDP-1
[255.114099] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[255.116339] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.651s)
[256.309318] [035/133] (787s left) vgem_basic (sysfs)
[256.364117] Starting subtest: sysfs
[256.366072] Subtest sysfs: SUCCESS (0.000s)
[256.422145] [036/133] (787s left) gem_barrier_race (remote-request)
[256.482000] Starting subtest: remote-request
[256.484367] Starting dynamic subtest: rcs0
[261.667881] Dynamic subtest rcs0: SUCCESS (5.185s)
[261.669782] Subtest remote-request: SUCCESS (5.186s)
[261.826018] [037/133] (782s left) syncobj_basic (bad-pad-handle-to-fd)
[261.874907] Starting subtest: bad-pad-handle-to-fd
[261.876593] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[261.981035] [038/133] (782s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[262.074882] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[262.078351] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[262.152133] [039/133] (782s left) gem_exec_schedule (deep)
[262.331686] Starting subtest: deep
[262.333917] Starting dynamic subtest: rcs0
[267.505210] Dynamic subtest rcs0: SKIP (5.169s)
[267.516196] Starting dynamic subtest: vcs0
[277.583432] Dynamic subtest vcs0: SUCCESS (10.081s)
[277.595880] Starting dynamic subtest: vcs1
[288.298558] Dynamic subtest vcs1: SUCCESS (10.712s)
[288.312647] Starting dynamic subtest: vecs0
[298.935679] Dynamic subtest vecs0: SUCCESS (10.631s)
[298.951400] Starting dynamic subtest: ccs0
[311.945196] Dynamic subtest ccs0: SUCCESS (13.004s)
[311.948258] Subtest deep: SUCCESS (49.606s)
[313.359958] [040/133] (731s left) kms_atomic_interruptible (legacy-pageflip)
[313.457418] Starting subtest: legacy-pageflip
[313.459751] Starting dynamic subtest: pipe-A-eDP-1
[320.851581] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.391s)
[320.853745] Subtest legacy-pageflip: SUCCESS (7.393s)
[321.674101] [041/133] (722s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[321.771148] Starting subtest: psr2-overlay-plane-move-continuous-sf
[321.773416] Starting dynamic subtest: pipe-A-eDP-1
[327.746711] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.979s)
[327.755631] Starting dynamic subtest: pipe-B-eDP-1
[334.464256] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.715s)
[334.466506] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.698s)
[335.333009] [042/133] (709s left) gem_render_copy_redux (flink)
[335.399391] Starting subtest: flink
[336.146376] Subtest flink: SUCCESS (0.747s)
[336.277249] [043/133] (708s left) syncobj_timeline (multi-wait-available-submitted)
[336.323017] Starting subtest: multi-wait-available-submitted
[336.324835] Subtest multi-wait-available-submitted: SUCCESS (0.002s)
[336.422575] [044/133] (708s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[336.519677] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[336.523049] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[336.590386] [045/133] (708s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[336.639449] Starting subtest: yf-tiled-to-vebox-y-tiled
[336.643210] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[336.825022] [046/133] (707s left) gem_exec_parallel (contexts)
[336.890904] Starting subtest: contexts
[336.893339] Starting dynamic subtest: rcs0
[340.020625] Dynamic subtest rcs0: SUCCESS (3.128s)
[340.032555] Starting dynamic subtest: bcs0
[343.365648] Dynamic subtest bcs0: SUCCESS (3.343s)
[343.377340] Starting dynamic subtest: vcs0
[347.914982] Dynamic subtest vcs0: SUCCESS (4.548s)
[347.929211] Starting dynamic subtest: vcs1
[352.083859] Dynamic subtest vcs1: SUCCESS (4.166s)
[352.094268] Starting dynamic subtest: vecs0
[356.086333] Dynamic subtest vecs0: SUCCESS (4.000s)
[356.098350] Starting dynamic subtest: ccs0
[359.877920] Dynamic subtest ccs0: SUCCESS (3.790s)
[359.880450] Subtest contexts: SUCCESS (22.988s)
[360.089618] [047/133] (684s left) perf_pmu (busy-accuracy-50)
[360.136737] Starting subtest: busy-accuracy-50
[360.138598] Starting dynamic subtest: rcs0
[361.681130] Dynamic subtest rcs0: SUCCESS (1.544s)
[361.692431] Starting dynamic subtest: bcs0
[363.229527] Dynamic subtest bcs0: SUCCESS (1.547s)
[363.241109] Starting dynamic subtest: vcs0
[364.771432] Dynamic subtest vcs0: SUCCESS (1.540s)
[364.780879] Starting dynamic subtest: vcs1
[366.314882] Dynamic subtest vcs1: SUCCESS (1.541s)
[366.323954] Starting dynamic subtest: vecs0
[367.853997] Dynamic subtest vecs0: SUCCESS (1.537s)
[367.863824] Starting dynamic subtest: ccs0
[369.406996] Dynamic subtest ccs0: SUCCESS (1.550s)
[369.409436] Subtest busy-accuracy-50: SUCCESS (9.270s)
[369.520582] [048/133] (675s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[369.620262] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[369.624417] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[369.731658] [049/133] (675s left) kms_chamelium_frames (dp-crc-single)
[370.102276] Subtest dp-crc-single: SKIP (0.000s)
[370.932391] [050/133] (674s left) i915_drm_fdinfo (most-busy-idle-check-all)
[370.978021] Starting subtest: most-busy-idle-check-all
[370.980493] Starting dynamic subtest: rcs0
[370.985284] Dynamic subtest rcs0: SKIP (0.003s)
[370.996149] Starting dynamic subtest: bcs0
[371.000740] Dynamic subtest bcs0: SKIP (0.000s)
[371.009803] Starting dynamic subtest: vcs0
[371.013978] Dynamic subtest vcs0: SKIP (0.000s)
[371.022628] Starting dynamic subtest: vcs1
[371.026873] Dynamic subtest vcs1: SKIP (0.000s)
[371.035587] Starting dynamic subtest: vecs0
[371.039712] Dynamic subtest vecs0: SKIP (0.000s)
[371.051298] Starting dynamic subtest: ccs0
[371.055671] Dynamic subtest ccs0: SKIP (0.000s)
[371.059886] Subtest most-busy-idle-check-all: SKIP (0.009s)
[371.097672] [051/133] (673s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[371.206275] Starting subtest: plane-downscale-factor-0-75-with-rotation
[371.210958] Starting dynamic subtest: pipe-A
[371.448565] Dynamic subtest pipe-A: SUCCESS (0.247s)
[371.460853] Starting dynamic subtest: pipe-B
[372.760437] Dynamic subtest pipe-B: SUCCESS (1.311s)
[372.769824] Starting dynamic subtest: pipe-C
[374.046702] Dynamic subtest pipe-C: SUCCESS (1.285s)
[374.057057] Starting dynamic subtest: pipe-D
[375.407692] Dynamic subtest pipe-D: SUCCESS (1.360s)
[375.409966] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.207s)
[376.575203] [052/133] (668s left) kms_color (gamma)
[376.674914] Starting subtest: gamma
[376.676790] Starting dynamic subtest: pipe-A-eDP-1
[377.388289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[377.397967] Starting dynamic subtest: pipe-B-eDP-1
[378.825468] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.436s)
[378.835175] Starting dynamic subtest: pipe-C-eDP-1
[380.160114] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.335s)
[380.170177] Starting dynamic subtest: pipe-D-eDP-1
[381.487376] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[381.489840] Subtest gamma: SUCCESS (4.813s)
[382.290443] [053/133] (662s left) kms_sequence (get-forked)
[382.395080] Starting subtest: get-forked
[382.397377] Starting dynamic subtest: pipe-A-eDP-1
[384.276882] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s)
[384.287202] Starting dynamic subtest: pipe-B-eDP-1
[386.856070] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.579s)
[386.866505] Starting dynamic subtest: pipe-C-eDP-1
[389.347887] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.488s)
[389.358023] Starting dynamic subtest: pipe-D-eDP-1
[391.897151] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.547s)
[391.899067] Subtest get-forked: SUCCESS (9.500s)
[392.717059] [054/133] (652s left) intel_hwmon (hwmon-read)
[392.779080] Subtest hwmon-read: SKIP (0.000s)
[392.855741] [055/133] (652s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[392.958789] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[392.961012] Starting dynamic subtest: pipe-A-eDP-1
[392.970205] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[392.980813] Starting dynamic subtest: pipe-B-eDP-1
[392.990039] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[393.001664] Starting dynamic subtest: pipe-C-eDP-1
[393.010619] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[393.019471] Starting dynamic subtest: pipe-D-eDP-1
[393.027982] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[393.032423] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[395.212466] [056/133] (649s left) i915_pm_rps (thresholds-park)
[395.273758] Starting subtest: thresholds-park
[395.277943] Subtest thresholds-park: SKIP (0.001s)
[395.392968] [057/133] (649s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[395.463176] Subtest no-spare-fences-busy: SKIP (0.000s)
[395.532865] [058/133] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[395.624682] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[395.628741] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[395.717743] [059/133] (649s left) perf (i915-ref-count)
[395.790050] Starting subtest: i915-ref-count
[395.837343] Subtest i915-ref-count: SUCCESS (0.047s)
[395.897636] [060/133] (649s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[395.991602] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[395.994120] Starting dynamic subtest: pipe-A-eDP-1
[396.051221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[396.060251] Starting dynamic subtest: pipe-B-eDP-1
[396.117387] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.066s)
[396.127698] Starting dynamic subtest: pipe-C-eDP-1
[396.184420] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.065s)
[396.194975] Starting dynamic subtest: pipe-D-eDP-1
[396.245755] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s)
[396.247657] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.258s)
[398.553258] [061/133] (646s left) i915_pm_rpm (system-suspend-devices)
[400.704886] Starting subtest: system-suspend-devices
[408.422872] Subtest system-suspend-devices: SUCCESS (7.716s)
[414.808230] [062/133] (636s left) gen9_exec_parse (bb-oversize)
[414.886058] Subtest bb-oversize: SKIP (0.000s)
[414.963998] [063/133] (636s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[415.067682] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[415.071785] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[415.158060] [064/133] (636s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[415.255890] Starting subtest: plane-all-modeset-transition-internal-panels
[415.257985] Starting dynamic subtest: pipe-A-eDP-1
[416.624556] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.369s)
[416.918015] Starting dynamic subtest: pipe-B-eDP-1
[417.957293] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s)
[418.226576] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.972s)
[419.077659] [065/133] (632s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[419.175784] Starting subtest: x-tiled-64bpp-rotate-90
[419.196272] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[419.310429] [066/133] (632s left) kms_getfb (getfb-handle-zero)
[419.410663] Starting subtest: getfb-handle-zero
[419.412956] Subtest getfb-handle-zero: SUCCESS (0.000s)
[419.518678] [067/133] (632s left) gem_tiled_pread_pwrite
[419.646710] [068/133] (632s left) gem_ctx_param (invalid-param-set)
[419.701753] Starting subtest: invalid-param-set
[419.704002] Subtest invalid-param-set: SUCCESS (0.000s)
[419.777078] [069/133] (631s left) kms_psr (psr-primary-page-flip)
[419.873997] Starting subtest: psr-primary-page-flip
[419.876270] Starting dynamic subtest: eDP-1
[421.572399] Dynamic subtest eDP-1: SUCCESS (1.697s)
[421.574820] Subtest psr-primary-page-flip: SUCCESS (1.699s)
[422.441567] [070/133] (629s left) syncobj_wait (single-wait-for-submit-submitted)
[422.492121] Starting subtest: single-wait-for-submit-submitted
[422.597025] Subtest single-wait-for-submit-submitted: SUCCESS (0.102s)
[422.673211] [071/133] (629s left) gem_caching (writes)
[422.735564] Subtest writes: SKIP (0.000s)
[422.809272] [072/133] (629s left) gem_exec_reloc (basic-gtt-cpu)
[422.871648] Subtest basic-gtt-cpu: SKIP (0.000s)
[422.941931] [073/133] (629s left) kms_vblank (ts-continuation-idle)
[423.033875] Starting subtest: ts-continuation-idle
[423.036096] Starting dynamic subtest: pipe-A-eDP-1
[423.434533] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[423.448567] Starting dynamic subtest: pipe-D-eDP-1
[424.535212] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.095s)
[424.537125] Subtest ts-continuation-idle: SUCCESS (1.500s)
[425.398582] [074/133] (626s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[425.501692] Starting subtest: 4-tiled-8bpp-rotate-90
[425.523032] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[425.627971] [075/133] (626s left) gem_ctx_persistence (legacy-engines-queued)
[425.694367] Starting subtest: legacy-engines-queued
[425.696603] Starting dynamic subtest: render
[425.771873] Dynamic subtest render: SUCCESS (0.077s)
[425.786499] Starting dynamic subtest: bsd1
[427.550885] Dynamic subtest bsd1: SUCCESS (1.775s)
[427.560208] Starting dynamic subtest: bsd2
[429.534343] Dynamic subtest bsd2: SUCCESS (1.981s)
[429.546891] Starting dynamic subtest: blt
[429.568195] Dynamic subtest blt: SUCCESS (0.033s)
[429.577126] Starting dynamic subtest: vebox
[431.517648] Dynamic subtest vebox: SUCCESS (1.947s)
[431.520412] Subtest legacy-engines-queued: SUCCESS (5.824s)
[431.602314] [076/133] (620s left) kms_setmode (invalid-clone-exclusive-crtc)
[431.674522] Starting subtest: invalid-clone-exclusive-crtc
[431.681091] Subtest invalid-clone-exclusive-crtc: SKIP (0.001s)
[431.790537] [077/133] (620s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[431.902116] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[431.904379] Starting dynamic subtest: pipe-A-eDP-1
[431.927060] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[431.937743] Starting dynamic subtest: pipe-B-eDP-1
[431.959180] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[431.968446] Starting dynamic subtest: pipe-C-eDP-1
[431.989704] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[431.998403] Starting dynamic subtest: pipe-D-eDP-1
[432.019879] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[432.023784] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[434.071076] [078/133] (618s left) kms_cursor_crc (cursor-sliding-max-size)
[434.362600] Starting subtest: cursor-sliding-max-size
[434.369248] Subtest cursor-sliding-max-size: SKIP (0.000s)
[434.491595] [079/133] (617s left) kms_chamelium_audio (dp-audio)
[434.885919] Subtest dp-audio: SKIP (0.000s)
[435.686811] [080/133] (616s left) gem_readwrite (read-write)
[435.750648] Subtest read-write: SKIP (0.000s)
[435.811576] [081/133] (616s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[435.921312] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[443.226709] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.308s)
[443.351777] [082/133] (608s left) perf (rc6-disable)
[443.450594] Starting subtest: rc6-disable
[443.642132] Subtest rc6-disable: SUCCESS (0.194s)
[443.690013] [083/133] (608s left) kms_psr (psr2-sprite-render)
[443.781699] Starting subtest: psr2-sprite-render
[443.783890] Starting dynamic subtest: eDP-1
[445.539683] Dynamic subtest eDP-1: SUCCESS (1.757s)
[445.541999] Subtest psr2-sprite-render: SUCCESS (1.759s)
[446.401996] [084/133] (606s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[446.498965] Starting subtest: primary-yf-tiled-reflect-x-0
[446.569869] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.071s)
[446.673733] [085/133] (605s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[446.771434] Starting subtest: 2x-absolute-wf_vblank-interruptible
[446.788565] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.016s)
[446.860057] [086/133] (605s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[446.968395] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[446.972733] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[447.051401] [087/133] (605s left) syncobj_timeline (wait-delayed-signal)
[447.108125] Starting subtest: wait-delayed-signal
[447.209162] Subtest wait-delayed-signal: SUCCESS (0.102s)
[447.288554] [088/133] (605s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[447.408441] Starting subtest: verify-pxp-key-change-after-suspend-resume
[454.578457] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.173s)
[465.723799] [089/133] (597s left) gem_exec_gttfill (basic)
[465.787468] Starting subtest: basic
[469.238767] Subtest basic: SUCCESS (3.450s)
[469.431489] [090/133] (594s left) gem_exec_alignment (pi)
[469.543365] Starting subtest: pi
[522.410460] Subtest pi: SUCCESS (52.852s)
[523.452216] [091/133] (540s left) kms_dsc (dsc-with-bpc)
[523.591096] Starting subtest: dsc-with-bpc
[523.620943] Subtest dsc-with-bpc: SKIP (0.001s)
[523.669828] [092/133] (540s left) kms_flip (modeset-vs-vblank-race)
[523.762051] Starting subtest: modeset-vs-vblank-race
[523.763937] Starting dynamic subtest: A-eDP1
[528.488699] Dynamic subtest A-eDP1: SUCCESS (4.727s)
[528.503194] Starting dynamic subtest: B-eDP1
[533.200844] Dynamic subtest B-eDP1: SUCCESS (4.708s)
[533.214136] Starting dynamic subtest: C-eDP1
[537.836910] Dynamic subtest C-eDP1: SUCCESS (4.632s)
[537.849054] Starting dynamic subtest: D-eDP1
[542.475599] Dynamic subtest D-eDP1: SUCCESS (4.635s)
[542.481127] Subtest modeset-vs-vblank-race: SUCCESS (18.718s)
[543.655773] [093/133] (520s left) gem_exec_schedule (out-order)
[543.740740] Starting subtest: out-order
[543.742900] Starting dynamic subtest: rcs0
[543.829534] Dynamic subtest rcs0: SUCCESS (0.096s)
[543.839373] Starting dynamic subtest: vcs0
[543.918667] Dynamic subtest vcs0: SUCCESS (0.087s)
[543.934449] Starting dynamic subtest: vcs1
[544.003680] Dynamic subtest vcs1: SUCCESS (0.083s)
[544.017405] Starting dynamic subtest: vecs0
[544.085279] Dynamic subtest vecs0: SUCCESS (0.081s)
[544.099080] Starting dynamic subtest: ccs0
[544.179950] Dynamic subtest ccs0: SUCCESS (0.093s)
[544.182603] Subtest out-order: SUCCESS (0.447s)
[545.638404] [094/133] (518s left) sriov_basic (enable-vfs-autoprobe-on)
[545.698711] Starting subtest: enable-vfs-autoprobe-on
[545.701040] Starting dynamic subtest: numvfs-1
[545.784139] Dynamic subtest numvfs-1: FAIL (0.028s)
[545.793746] Starting dynamic subtest: numvfs-2
[545.866034] Dynamic subtest numvfs-2: FAIL (0.004s)
[545.877366] Starting dynamic subtest: numvfs-3
[545.949554] Dynamic subtest numvfs-3: FAIL (0.003s)
[545.960155] Starting dynamic subtest: numvfs-4
[546.031670] Dynamic subtest numvfs-4: FAIL (0.004s)
[546.042215] Starting dynamic subtest: numvfs-5
[546.113649] Dynamic subtest numvfs-5: FAIL (0.004s)
[546.124981] Starting dynamic subtest: numvfs-6
[546.197045] Dynamic subtest numvfs-6: FAIL (0.004s)
[546.207856] Starting dynamic subtest: numvfs-7
[546.282403] Dynamic subtest numvfs-7: FAIL (0.004s)
[546.293847] Starting dynamic subtest: numvfs-random
[546.366474] Dynamic subtest numvfs-random: FAIL (0.004s)
[546.377345] Starting dynamic subtest: numvfs-all
[546.450010] Dynamic subtest numvfs-all: FAIL (0.511s)
[546.452328] Subtest enable-vfs-autoprobe-on: FAIL (0.572s)
[546.492716] [095/133] (517s left) dumb_buffer (invalid-bpp)
[546.549733] Starting subtest: invalid-bpp
[546.551806] Subtest invalid-bpp: SUCCESS (0.000s)
[546.641878] [096/133] (517s left) gem_exec_schedule (u-fairslice-all)
[546.701221] Starting subtest: u-fairslice-all
[548.783624] Subtest u-fairslice-all: SUCCESS (2.083s)
[550.678729] [097/133] (513s left) gem_mmap_gtt (basic-wc)
[550.734813] Subtest basic-wc: SKIP (0.000s)
[550.804333] [098/133] (513s left) kms_psr (fbc-psr-dpms)
[550.906523] Starting subtest: fbc-psr-dpms
[550.908795] Starting dynamic subtest: eDP-1
[550.913045] Dynamic subtest eDP-1: SKIP (0.000s)
[550.917291] Subtest fbc-psr-dpms: SKIP (0.001s)
[550.993006] [099/133] (513s left) gem_exec_whisper (basic-contexts-forked-all)
[551.054538] Starting subtest: basic-contexts-forked-all
[571.243595] Subtest basic-contexts-forked-all: SUCCESS (20.180s)
[571.427397] [100/133] (492s left) kms_psr (pr-sprite-plane-onoff)
[571.528721] Starting subtest: pr-sprite-plane-onoff
[571.533087] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[571.622212] [101/133] (492s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[571.718476] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[578.798955] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.081s)
[578.950992] [102/133] (485s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[579.018872] Starting subtest: single-wait-all-for-submit-available-submitted
[579.021120] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[579.134704] [103/133] (485s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[579.190406] Starting subtest: multi-wait-for-submit-submitted-signaled
[579.192708] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[579.281082] [104/133] (485s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[579.400093] Starting subtest: cursorA-vs-flipB-varying-size
[579.404682] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[579.548118] [105/133] (484s left) gem_mmap_gtt (cpuset-big-copy-xy)
[579.620398] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[579.687370] [106/133] (484s left) gem_exec_params (invalid-fence-in)
[579.744879] Starting subtest: invalid-fence-in
[579.747077] Subtest invalid-fence-in: SUCCESS (0.000s)
[579.848553] [107/133] (484s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[579.938673] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[579.942213] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[580.010272] [108/133] (484s left) gem_mmap (pf-nonblock)
[580.059424] Subtest pf-nonblock: SKIP (0.000s)
[580.145863] [109/133] (484s left) gem_exec_params (sol-reset-not-gen7)
[580.205962] Starting subtest: sol-reset-not-gen7
[580.207974] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[580.327568] [110/133] (484s left) gem_exec_balancer (parallel-contexts)
[580.582910] Starting subtest: parallel-contexts
[583.212530] Subtest parallel-contexts: SUCCESS (2.629s)
[583.318518] [111/133] (481s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[583.370903] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[583.373305] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[583.480426] [112/133] (481s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[583.871657] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[584.698408] [113/133] (479s left) kms_rotation_crc (exhaust-fences)
[584.793487] Starting subtest: exhaust-fences
[584.797314] Subtest exhaust-fences: SKIP (0.000s)
[584.866600] [114/133] (479s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[584.955713] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[592.465715] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.511s)
[592.618301] [115/133] (472s left) gem_wait (write-wait)
[592.686505] Starting subtest: write-wait
[592.688684] Starting dynamic subtest: all-engines
[593.823667] Dynamic subtest all-engines: SUCCESS (1.136s)
[593.836697] Starting dynamic subtest: rcs0
[594.890329] Dynamic subtest rcs0: SUCCESS (1.064s)
[594.909480] Starting dynamic subtest: bcs0
[595.951299] Dynamic subtest bcs0: SUCCESS (1.059s)
[595.968497] Starting dynamic subtest: vcs0
[597.007441] Dynamic subtest vcs0: SUCCESS (1.053s)
[597.025487] Starting dynamic subtest: vcs1
[598.061204] Dynamic subtest vcs1: SUCCESS (1.051s)
[598.079436] Starting dynamic subtest: vecs0
[599.114049] Dynamic subtest vecs0: SUCCESS (1.050s)
[599.131557] Starting dynamic subtest: ccs0
[600.170994] Dynamic subtest ccs0: SUCCESS (1.054s)
[600.173630] Subtest write-wait: SUCCESS (7.484s)
[600.370789] [116/133] (464s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[600.474592] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[601.265590] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s)
[601.453479] [117/133] (463s left) api_intel_bb (misplaced-blitter)
[601.523136] Starting subtest: misplaced-blitter
[601.529936] Subtest misplaced-blitter: SUCCESS (0.007s)
[601.672388] [118/133] (463s left) gem_softpin (allocator-evict)
[601.749944] Starting subtest: allocator-evict
[601.752170] Starting dynamic subtest: rcs0
[624.854173] Dynamic subtest rcs0: SUCCESS (23.098s)
[624.864920] Starting dynamic subtest: bcs0
[648.397297] Dynamic subtest bcs0: SUCCESS (23.537s)
[648.408647] Starting dynamic subtest: vcs0
[672.366627] Dynamic subtest vcs0: SUCCESS (23.961s)
[672.378320] Starting dynamic subtest: vcs1
[696.177467] Dynamic subtest vcs1: SUCCESS (23.803s)
[696.190276] Starting dynamic subtest: vecs0
[719.844699] Dynamic subtest vecs0: SUCCESS (23.661s)
[719.857386] Starting dynamic subtest: ccs0
[743.412273] Dynamic subtest ccs0: SUCCESS (23.560s)
[743.415012] Subtest allocator-evict: SUCCESS (141.629s)
[743.495061] [119/133] (321s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[743.657936] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[743.662196] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[743.771659] [120/133] (321s left) kms_lease (empty-lease)
[743.858700] Starting subtest: empty-lease
[743.860948] Starting dynamic subtest: pipe-A-eDP-1
[743.863253] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[743.878530] Starting dynamic subtest: pipe-B-eDP-1
[743.880750] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[743.893465] Starting dynamic subtest: pipe-C-eDP-1
[743.895661] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[743.905123] Starting dynamic subtest: pipe-D-eDP-1
[743.907307] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[743.909536] Subtest empty-lease: SUCCESS (0.009s)
[743.968484] [121/133] (321s left) kms_atomic_interruptible (legacy-dpms)
[744.066567] Starting subtest: legacy-dpms
[744.068750] Starting dynamic subtest: pipe-A-eDP-1
[751.521303] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.451s)
[751.523542] Subtest legacy-dpms: SUCCESS (7.453s)
[752.360043] [122/133] (312s left) kms_psr (fbc-psr2-primary-render)
[752.456065] Starting subtest: fbc-psr2-primary-render
[752.458320] Starting dynamic subtest: eDP-1
[752.462750] Dynamic subtest eDP-1: SKIP (0.000s)
[752.466856] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[752.530866] [123/133] (312s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[752.625990] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[752.630315] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[752.728395] [124/133] (312s left) gem_ctx_persistence (engines-mixed)
[752.787660] Starting subtest: engines-mixed
[752.790003] Starting dynamic subtest: rcs0
[752.884649] Dynamic subtest rcs0: SUCCESS (0.096s)
[752.897215] Starting dynamic subtest: bcs0
[752.945656] Dynamic subtest bcs0: SUCCESS (0.059s)
[752.957885] Starting dynamic subtest: vcs0
[752.997806] Dynamic subtest vcs0: SUCCESS (0.050s)
[753.009732] Starting dynamic subtest: vcs1
[753.023917] Dynamic subtest vcs1: SUCCESS (0.025s)
[753.033675] Starting dynamic subtest: vecs0
[753.102277] Dynamic subtest vecs0: SUCCESS (0.077s)
[753.114839] Starting dynamic subtest: ccs0
[753.159589] Dynamic subtest ccs0: SUCCESS (0.055s)
[753.162479] Subtest engines-mixed: SUCCESS (0.372s)
[753.246322] [125/133] (311s left) perf (invalid-create-userspace-config)
[753.358722] Starting subtest: invalid-create-userspace-config
[753.360876] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[753.401047] [126/133] (311s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[753.492706] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[753.495967] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[753.585535] [127/133] (311s left) kms_pm_backlight (basic-brightness)
[753.677877] Starting subtest: basic-brightness
[753.748813] Starting dynamic subtest: eDP-1
[754.056449] Dynamic subtest eDP-1: SUCCESS (0.307s)
[754.058782] Subtest basic-brightness: SUCCESS (0.377s)
[754.870288] [128/133] (310s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[754.975970] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[754.979994] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[755.093567] [129/133] (310s left) gem_close (basic)
[755.145096] Starting subtest: basic
[755.147204] Subtest basic: SUCCESS (0.000s)
[755.267837] [130/133] (310s left) perf_pmu (busy-idle-check-all)
[755.310418] Starting subtest: busy-idle-check-all
[755.312553] Starting dynamic subtest: rcs0
[755.961932] Dynamic subtest rcs0: SUCCESS (0.652s)
[755.975308] Starting dynamic subtest: bcs0
[756.613513] Dynamic subtest bcs0: SUCCESS (0.649s)
[756.627678] Starting dynamic subtest: vcs0
[758.527995] Dynamic subtest vcs0: SUCCESS (1.910s)
[758.540639] Starting dynamic subtest: vcs1
[760.576246] Dynamic subtest vcs1: SUCCESS (2.045s)
[760.589585] Starting dynamic subtest: vecs0
[762.560101] Dynamic subtest vecs0: SUCCESS (1.980s)
[762.572977] Starting dynamic subtest: ccs0
[763.215892] Dynamic subtest ccs0: SUCCESS (0.654s)
[763.218474] Subtest busy-idle-check-all: SUCCESS (7.905s)
[763.337420] [131/133] (302s left) syncobj_wait (wait-all-interrupted)
[763.405038] Starting subtest: wait-all-interrupted
[763.512338] Subtest wait-all-interrupted: SUCCESS (0.102s)
[763.588598] [132/133] (301s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[763.705829] Starting subtest: invalid-modeset-force-ultra-joiner
[763.710166] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[763.772115] [133/133] (301s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[763.835940] Starting subtest: etime-multi-wait-all-available-unsubmitted
[763.940635] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.104s)
[764.015425] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: gem_exercise_blt
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_flush
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: tools_test
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: i915_fb_tiling
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: kms_hdr
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_pm_backlight
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_pipe_crc_basic
results: parsing output: 21/ for test: api_intel_allocator
results: parsing output: 22/ for test: kms_dirtyfb
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: gem_compute
results: parsing output: 27/ for test: kms_content_protection
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: vgem_basic
results: parsing output: 35/ for test: gem_barrier_race
results: parsing output: 36/ for test: syncobj_basic
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_atomic_interruptible
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: gem_render_copy_redux
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: gem_exec_parallel
results: parsing output: 46/ for test: perf_pmu
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_chamelium_frames
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: kms_color
results: parsing output: 52/ for test: kms_sequence
results: parsing output: 53/ for test: intel_hwmon
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: i915_pm_rps
results: parsing output: 56/ for test: gem_fenced_exec_thrash
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: i915_pm_rpm
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_atomic_transition
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_getfb
results: parsing output: 66/ for test: gem_tiled_pread_pwrite
results: parsing output: 67/ for test: gem_ctx_param
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: gem_caching
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: kms_setmode
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_chamelium_audio
results: parsing output: 79/ for test: gem_readwrite
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: gem_pxp
results: parsing output: 88/ for test: gem_exec_gttfill
results: parsing output: 89/ for test: gem_exec_alignment
results: parsing output: 90/ for test: kms_dsc
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: sriov_basic
results: parsing output: 94/ for test: dumb_buffer
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_exec_whisper
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: gem_mmap
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_chamelium_hpd
results: parsing output: 112/ for test: kms_rotation_crc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_wait
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: gem_softpin
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_lease
results: parsing output: 120/ for test: kms_atomic_interruptible
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_pm_backlight
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_close
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_joiner
results: parsing output: 132/ for test: syncobj_timeline
Done.