[62.238091] Initializing watchdogs
[62.238246]   /dev/watchdog0
[62.254559] [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]
[62.258899] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.261096] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.264415] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[62.396574] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[62.400957] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[62.497365] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[62.596181] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[62.600649] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[62.692995] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[62.791281] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[63.480242] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.691s)
[63.648360] [004/133] (959s left) gen7_exec_parse (basic-offset)
[63.708991] Subtest basic-offset: SKIP (0.000s)
[63.772348] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[63.881361] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[68.369093] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.491s)
[69.564516] [006/133] (953s left) tools_test (tools_test)
[69.613827] Starting subtest: tools_test
[69.661073] Subtest tools_test: SUCCESS (0.065s)
[69.717282] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[69.810692] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[69.816544] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[70.895693] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[71.002759] Starting subtest: modeset-vs-vblank-race
[71.005192] Starting dynamic subtest: A-eDP1
[75.738123] Dynamic subtest A-eDP1: SUCCESS (4.735s)
[75.748861] Starting dynamic subtest: B-eDP1
[80.462477] Dynamic subtest B-eDP1: SUCCESS (4.723s)
[80.472495] Starting dynamic subtest: C-eDP1
[85.167048] Dynamic subtest C-eDP1: SUCCESS (4.702s)
[85.177736] Starting dynamic subtest: D-eDP1
[89.703933] Dynamic subtest D-eDP1: SUCCESS (4.536s)
[89.706220] Subtest modeset-vs-vblank-race: SUCCESS (18.704s)
[90.869518] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[93.121616] Starting subtest: reg-read-ioctl
[95.507524] Subtest reg-read-ioctl: SUCCESS (2.387s)
[95.898765] [010/133] (927s left) gem_exec_balancer (hang)
[96.163068] Starting subtest: hang
[97.882164] Subtest hang: SUCCESS (1.722s)
[97.994106] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[98.101501] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[98.106741] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[98.173335] [012/133] (925s left) perf_pmu (faulting-read)
[98.217597] Starting subtest: faulting-read
[98.219855] Starting dynamic subtest: wb
[98.221853] Dynamic subtest wb: SUCCESS (0.001s)
[98.230906] Starting dynamic subtest: wc
[98.233043] Dynamic subtest wc: SUCCESS (0.000s)
[98.240445] Starting dynamic subtest: uc
[98.242293] Dynamic subtest uc: SUCCESS (0.000s)
[98.244139] Subtest faulting-read: SUCCESS (0.002s)
[98.321956] [013/133] (924s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[98.422198] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[98.426182] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[98.514833] [014/133] (924s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[98.892870] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[99.683593] [015/133] (923s left) gem_exec_schedule (pi-distinct-iova)
[99.859881] Starting subtest: pi-distinct-iova
[99.862047] Starting dynamic subtest: rcs0
[99.931757] Dynamic subtest rcs0: SUCCESS (0.075s)
[99.941234] Starting dynamic subtest: vcs0
[99.999546] Dynamic subtest vcs0: SUCCESS (0.068s)
[100.010804] Starting dynamic subtest: vcs1
[100.062798] Dynamic subtest vcs1: SUCCESS (0.061s)
[100.072642] Starting dynamic subtest: vecs0
[100.134534] Dynamic subtest vecs0: SUCCESS (0.071s)
[100.145698] Starting dynamic subtest: ccs0
[100.206664] Dynamic subtest ccs0: SUCCESS (0.072s)
[100.209924] Subtest pi-distinct-iova: SUCCESS (0.350s)
[101.989469] [016/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[102.097445] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[102.101592] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[102.202349] [017/133] (921s left) drm_read (short-buffer-block)
[102.350085] Starting subtest: short-buffer-block
[102.352293] Subtest short-buffer-block: SUCCESS (0.000s)
[102.473575] [018/133] (920s left) perf (oa-formats)
[102.599178] Starting subtest: oa-formats
[102.601059] Starting dynamic subtest: 0-rcs0
[102.613538] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[102.621772] Starting dynamic subtest: 1-vecs0
[102.633829] Dynamic subtest 1-vecs0: SUCCESS (0.020s)
[102.636186] Subtest oa-formats: SUCCESS (0.037s)
[102.680261] [019/133] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[102.777610] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[102.782460] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[102.867481] [020/133] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[102.951427] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[102.954944] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[103.054316] [021/133] (920s left) kms_psr (pr-basic)
[103.153052] Starting subtest: pr-basic
[103.156593] Subtest pr-basic: SKIP (0.000s)
[103.235722] [022/133] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[103.330019] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[103.331923] Starting dynamic subtest: pipe-A-eDP-1
[103.351892] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[103.368117] Starting dynamic subtest: pipe-B-eDP-1
[103.386762] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[103.402766] Starting dynamic subtest: pipe-C-eDP-1
[103.421508] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[103.430340] Starting dynamic subtest: pipe-D-eDP-1
[103.447619] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[103.450795] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[105.559571] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[105.929640] Subtest hdmi-mode-timings: SKIP (0.000s)
[106.775862] [024/133] (916s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[106.929714] Starting subtest: dp-mst-lic-type-0-hdcp14
[106.934289] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[107.050380] [025/133] (916s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[107.152306] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[107.156177] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[107.230167] [026/133] (916s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[107.322956] Starting subtest: primary-4-tiled-reflect-x-180
[114.305488] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.985s)
[115.492386] [027/133] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[115.593043] Starting subtest: 2x-flip-vs-panning-interruptible
[115.604976] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[115.684554] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[115.794730] Starting subtest: plain-flip-fb-recreate
[115.797225] Starting dynamic subtest: A-eDP1
[124.674672] Dynamic subtest A-eDP1: SUCCESS (8.883s)
[124.684686] Starting dynamic subtest: B-eDP1
[133.500129] Dynamic subtest B-eDP1: SUCCESS (8.824s)
[133.512100] Starting dynamic subtest: C-eDP1
[142.320993] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[142.328910] Starting dynamic subtest: D-eDP1
[151.147474] Dynamic subtest D-eDP1: SUCCESS (8.824s)
[151.151508] Subtest plain-flip-fb-recreate: SUCCESS (35.360s)
[152.357579] [029/133] (871s left) gem_tiled_partial_pwrite_pread (writes)
[152.417730] Subtest writes: SKIP (0.000s)
[152.487807] [030/133] (871s left) gem_lmem_swapping (heavy-verify-random)
[152.535457] Subtest heavy-verify-random: SKIP (0.000s)
[152.573545] [031/133] (871s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[152.665417] Starting subtest: x-tiled-64bpp-rotate-90
[152.684488] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[152.806586] [032/133] (871s left) vgem_basic (debugfs)
[152.909107] Starting subtest: debugfs
[152.910977] Subtest debugfs: SUCCESS (0.000s)
[152.958805] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[152.962253] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[153.054923] Starting subtest: legacy-setmode
[153.057287] Starting dynamic subtest: pipe-A-eDP-1
[159.964830] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.907s)
[159.966847] Subtest legacy-setmode: SUCCESS (6.908s)
[160.829731] [034/133] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[160.959760] Starting subtest: reject-modify-context-protection-off-2
[160.962225] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[161.068088] [035/133] (863s left) gem_exec_basic (basic)
[161.140603] Starting subtest: basic
[161.143016] Starting dynamic subtest: rcs0-smem
[161.145290] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[161.158468] Starting dynamic subtest: bcs0-smem
[161.160778] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[161.171422] Starting dynamic subtest: vcs0-smem
[161.173685] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[161.181571] Starting dynamic subtest: vcs1-smem
[161.183807] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[161.191421] Starting dynamic subtest: vecs0-smem
[161.193706] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[161.201502] Starting dynamic subtest: ccs0-smem
[161.203724] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[161.205996] Subtest basic: SUCCESS (0.011s)
[162.960370] [036/133] (861s left) api_intel_bb (offset-control)
[163.009264] Starting subtest: offset-control
[163.014303] Subtest offset-control: SUCCESS (0.007s)
[163.134184] [037/133] (861s left) kms_joiner (basic-max-non-joiner)
[163.223889] Starting subtest: basic-max-non-joiner
[163.228590] Subtest basic-max-non-joiner: SKIP (0.000s)
[163.293297] [038/133] (860s left) kms_addfb_basic (small-bo)
[163.389063] Starting subtest: small-bo
[163.391200] Subtest small-bo: SUCCESS (0.000s)
[163.479853] [039/133] (860s left) i915_query (query-topology-garbage-items)
[163.545101] Starting subtest: query-topology-garbage-items
[163.547431] Subtest query-topology-garbage-items: SUCCESS (0.001s)
[163.664352] [040/133] (860s left) perf (gen12-group-exclusive-stream-ctx-handle)
[163.777041] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[163.807661] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.030s)
[163.852256] [041/133] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[164.897647] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[164.902174] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[164.989148] [042/133] (859s left) gem_exec_params (cliprects-invalid)
[165.052163] Starting subtest: cliprects-invalid
[165.054397] Subtest cliprects-invalid: SUCCESS (0.000s)
[165.148487] [043/133] (859s left) kms_cursor_crc (cursor-random-64x64)
[165.328998] Starting subtest: cursor-random-64x64
[165.331332] Starting dynamic subtest: pipe-A-eDP-1
[168.658523] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.326s)
[168.683165] Starting dynamic subtest: pipe-D-eDP-1
[172.647423] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.971s)
[172.649631] Subtest cursor-random-64x64: SUCCESS (7.320s)
[173.498867] [044/133] (850s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[173.596214] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[173.600455] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[173.683616] [045/133] (850s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[173.777730] Starting subtest: 4-tiled-16bpp-rotate-180
[175.134538] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.357s)
[175.244426] [046/133] (849s left) dumb_buffer (create-valid-dumb)
[175.300605] Starting subtest: create-valid-dumb
[175.302491] Subtest create-valid-dumb: SUCCESS (0.000s)
[175.388828] [047/133] (849s left) gem_softpin (zero)
[175.445220] Starting subtest: zero
[175.448968] Subtest zero: SUCCESS (0.004s)
[175.560378] [048/133] (849s left) gem_blits (basic)
[175.615880] Starting subtest: basic
[176.982748] Subtest basic: SUCCESS (1.366s)
[177.093348] [049/133] (847s left) gem_busy (close-race)
[177.163736] Starting subtest: close-race
[200.916898] Subtest close-race: SUCCESS (23.751s)
[201.290503] [050/133] (823s left) gem_exec_alignment (forked)
[201.401809] Starting subtest: forked
[239.974010] Subtest forked: SUCCESS (38.573s)
[240.057815] [051/133] (784s left) syncobj_eventfd (binary-wait-before-signal)
[240.155491] Starting subtest: binary-wait-before-signal
[240.183091] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[240.278372] [052/133] (784s left) prime_mmap (test_errors)
[240.353309] Starting subtest: test_errors
[240.355254] Starting dynamic subtest: test_errors-smem
[240.450051] Dynamic subtest test_errors-smem: SUCCESS (0.097s)
[240.452468] Subtest test_errors: SUCCESS (0.098s)
[240.574541] [053/133] (784s left) gem_ctx_persistence (heartbeat-stop)
[240.629182] Starting subtest: heartbeat-stop
[240.633535] Subtest heartbeat-stop: SKIP (0.000s)
[240.719970] [054/133] (784s left) gem_ctx_param (invalid-get-ringsize)
[240.768622] Starting subtest: invalid-get-ringsize
[240.770797] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[240.861886] [055/133] (784s left) i915_query (query-topology-matches-eu-total)
[240.911781] Starting subtest: query-topology-matches-eu-total
[240.913959] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[240.997790] [056/133] (783s left) kms_cursor_edge_walk (64x64-right-edge)
[241.095688] Starting subtest: 64x64-right-edge
[241.097653] Starting dynamic subtest: pipe-A-eDP-1
[244.558068] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.463s)
[244.567924] Starting dynamic subtest: pipe-D-eDP-1
[247.687371] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[247.689739] Subtest 64x64-right-edge: SUCCESS (6.592s)
[248.546342] [057/133] (776s left) kms_plane (plane-position-covered)
[248.641146] Starting subtest: plane-position-covered
[249.186538] Starting dynamic subtest: pipe-A-plane-1
[250.477190] Dynamic subtest pipe-A-plane-1: SUCCESS (1.291s)
[250.486573] Starting dynamic subtest: pipe-A-plane-2
[251.734261] Dynamic subtest pipe-A-plane-2: SUCCESS (1.253s)
[251.747077] Starting dynamic subtest: pipe-A-plane-3
[253.062271] Dynamic subtest pipe-A-plane-3: SUCCESS (1.327s)
[253.072545] Starting dynamic subtest: pipe-A-plane-4
[254.279678] Dynamic subtest pipe-A-plane-4: SUCCESS (1.219s)
[254.289690] Starting dynamic subtest: pipe-A-plane-5
[254.306080] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[255.444335] Starting dynamic subtest: pipe-B-plane-1
[256.661260] Dynamic subtest pipe-B-plane-1: SUCCESS (1.227s)
[256.670490] Starting dynamic subtest: pipe-B-plane-2
[257.906028] Dynamic subtest pipe-B-plane-2: SUCCESS (1.243s)
[257.915170] Starting dynamic subtest: pipe-B-plane-3
[259.128752] Dynamic subtest pipe-B-plane-3: SUCCESS (1.220s)
[259.146991] Starting dynamic subtest: pipe-B-plane-4
[260.367162] Dynamic subtest pipe-B-plane-4: SUCCESS (1.240s)
[260.386264] Starting dynamic subtest: pipe-B-plane-5
[260.395315] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[260.397258] Subtest plane-position-covered: SUCCESS (11.753s)
[261.185752] [058/133] (763s left) kms_frontbuffer_tracking (psr-suspend)
[261.285659] Starting subtest: psr-suspend
[300.061113] Subtest psr-suspend: SUCCESS (8.297s)
[300.193848] [059/133] (724s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[300.312615] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[300.317141] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[300.409668] [060/133] (724s left) gem_exec_schedule (fairslice)
[300.489280] Starting subtest: fairslice
[300.491740] Starting dynamic subtest: rcs0
[302.504126] Dynamic subtest rcs0: SUCCESS (2.017s)
[302.516028] Starting dynamic subtest: bcs0
[304.547546] Dynamic subtest bcs0: SUCCESS (2.023s)
[304.563149] Starting dynamic subtest: vcs0
[306.553143] Dynamic subtest vcs0: SUCCESS (2.017s)
[306.563472] Starting dynamic subtest: vcs1
[308.571858] Dynamic subtest vcs1: SUCCESS (2.014s)
[308.582357] Starting dynamic subtest: vecs0
[310.588901] Dynamic subtest vecs0: SUCCESS (2.015s)
[310.599396] Starting dynamic subtest: ccs0
[312.608457] Dynamic subtest ccs0: SUCCESS (2.018s)
[312.610666] Subtest fairslice: SUCCESS (12.111s)
[312.907997] [061/133] (712s left) sw_sync (alloc_fence_invalid_timeline)
[312.946103] Starting subtest: alloc_fence_invalid_timeline
[312.948378] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[313.002272] [062/133] (712s left) gem_exec_whisper (basic-fds-forked)
[313.067268] Starting subtest: basic-fds-forked
[337.031051] Subtest basic-fds-forked: SUCCESS (23.947s)
[337.221782] [063/133] (688s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[337.323941] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[337.328226] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[337.423952] [064/133] (687s left) gem_vm_create (execbuf)
[337.482761] Starting subtest: execbuf
[337.490445] Subtest execbuf: SUCCESS (0.008s)
[337.601256] [065/133] (687s left) kms_cursor_crc (cursor-onscreen-256x85)
[337.858251] Starting subtest: cursor-onscreen-256x85
[337.902377] Subtest cursor-onscreen-256x85: SKIP (0.039s)
[338.087868] [066/133] (687s left) kms_plane_alpha_blend (coverage-7efc)
[338.175136] Starting subtest: coverage-7efc
[338.462439] Starting dynamic subtest: pipe-A-eDP-1
[339.050182] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[339.077778] Starting dynamic subtest: pipe-D-eDP-1
[340.427839] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.356s)
[340.430098] Subtest coverage-7efc: SUCCESS (2.252s)
[341.259337] [067/133] (684s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[341.355478] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[341.357795] Starting dynamic subtest: pipe-A
[341.375490] Dynamic subtest pipe-A: SKIP (0.017s)
[341.386049] Starting dynamic subtest: pipe-B
[341.406473] Dynamic subtest pipe-B: SKIP (0.030s)
[341.416340] Starting dynamic subtest: pipe-C
[341.434335] Dynamic subtest pipe-C: SKIP (0.029s)
[341.444081] Starting dynamic subtest: pipe-D
[341.463546] Dynamic subtest pipe-D: SKIP (0.028s)
[341.467180] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.106s)
[341.562199] [068/133] (683s left) vgem_basic (busy-fence)
[341.600971] Starting subtest: busy-fence
[341.603189] Subtest busy-fence: SUCCESS (0.000s)
[341.660482] [069/133] (683s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[341.751660] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[341.781878] Starting dynamic subtest: pipe-A-plane-0
[342.214996] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[342.226976] Starting dynamic subtest: pipe-A-plane-3
[342.470532] Dynamic subtest pipe-A-plane-3: SUCCESS (0.253s)
[342.482382] Starting dynamic subtest: pipe-A-plane-5
[342.486144] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[343.539207] Starting dynamic subtest: pipe-B-plane-0
[343.953534] Dynamic subtest pipe-B-plane-0: SUCCESS (0.422s)
[343.965885] Starting dynamic subtest: pipe-B-plane-3
[344.231447] Dynamic subtest pipe-B-plane-3: SUCCESS (0.277s)
[344.245216] Starting dynamic subtest: pipe-B-plane-5
[344.249945] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[344.583003] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.831s)
[345.436121] [070/133] (680s left) kms_addfb_basic (invalid-set-prop-any)
[345.498362] Starting subtest: invalid-set-prop-any
[345.500193] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[345.626469] [071/133] (679s left) kms_addfb_basic (size-max)
[345.719277] Starting subtest: size-max
[345.721187] Subtest size-max: SUCCESS (0.000s)
[345.833773] [072/133] (679s left) kms_addfb_basic (bad-pitch-128)
[345.876539] Starting subtest: bad-pitch-128
[345.878737] Subtest bad-pitch-128: SUCCESS (0.000s)
[346.036965] [073/133] (679s left) syncobj_timeline (single-wait-available-submitted)
[346.091184] Starting subtest: single-wait-available-submitted
[346.093380] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[346.186537] [074/133] (679s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[346.279205] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[347.303879] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.024s)
[347.439507] [075/133] (678s left) gem_pread (exhaustion)
[347.491985] Subtest exhaustion: SKIP (0.000s)
[347.547598] [076/133] (678s left) kms_frontbuffer_tracking (psr-1p-rte)
[347.636487] Starting subtest: psr-1p-rte
[353.039679] Subtest psr-1p-rte: SUCCESS (5.403s)
[353.173704] [077/133] (672s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[353.309626] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[370.803070] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.486s)
[371.610229] [078/133] (654s left) api_intel_allocator (fork-simple-once)
[371.676442] Starting subtest: fork-simple-once
[371.691850] Subtest fork-simple-once: SUCCESS (0.018s)
[371.832817] [079/133] (654s left) gem_set_tiling_vs_pwrite
[371.958315] [080/133] (654s left) kms_pm_backlight (brightness-with-dpms)
[372.059286] Starting subtest: brightness-with-dpms
[372.111380] Starting dynamic subtest: eDP-1
[374.486369] Dynamic subtest eDP-1: SUCCESS (2.377s)
[374.488953] Subtest brightness-with-dpms: SUCCESS (2.429s)
[375.354238] [081/133] (650s left) kms_lease (lease-invalid-crtc)
[375.454231] Starting subtest: lease-invalid-crtc
[375.456396] Starting dynamic subtest: pipe-A-eDP-1
[375.458601] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[375.468862] Starting dynamic subtest: pipe-B-eDP-1
[375.471065] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[375.480642] Starting dynamic subtest: pipe-C-eDP-1
[375.482911] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[375.492267] Starting dynamic subtest: pipe-D-eDP-1
[375.494472] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[375.496623] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[375.534485] [082/133] (650s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[375.631509] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[375.635484] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[375.725957] [083/133] (650s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[375.810633] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[382.672553] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.859s)
[382.809609] [084/133] (643s left) kms_dp_linktrain_fallback (dp-fallback)
[382.910569] Starting subtest: dp-fallback
[382.917359] Subtest dp-fallback: SKIP (0.000s)
[382.983155] [085/133] (643s left) kms_vblank (ts-continuation-idle)
[383.089397] Starting subtest: ts-continuation-idle
[383.091209] Starting dynamic subtest: pipe-A-eDP-1
[383.490479] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s)
[383.504623] Starting dynamic subtest: pipe-D-eDP-1
[384.569779] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.075s)
[384.572100] Subtest ts-continuation-idle: SUCCESS (1.479s)
[385.437768] [086/133] (640s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[385.529119] Starting subtest: fbc-psr-cursor-mmap-gtt
[385.531403] Starting dynamic subtest: eDP-1
[385.535650] Dynamic subtest eDP-1: SKIP (0.000s)
[385.539904] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[385.602942] [087/133] (640s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[385.713841] Starting subtest: cursor-vs-flip-varying-size
[416.808526] Subtest cursor-vs-flip-varying-size: SUCCESS (31.106s)
[417.666423] [088/133] (608s left) i915_drm_fdinfo (busy-check-all)
[417.709565] Starting subtest: busy-check-all
[417.711916] Starting dynamic subtest: rcs0
[417.716533] Dynamic subtest rcs0: SKIP (0.003s)
[417.732133] Starting dynamic subtest: bcs0
[417.736258] Dynamic subtest bcs0: SKIP (0.000s)
[417.746135] Starting dynamic subtest: vcs0
[417.750496] Dynamic subtest vcs0: SKIP (0.000s)
[417.760204] Starting dynamic subtest: vcs1
[417.764478] Dynamic subtest vcs1: SKIP (0.000s)
[417.774243] Starting dynamic subtest: vecs0
[417.778565] Dynamic subtest vecs0: SKIP (0.000s)
[417.791195] Starting dynamic subtest: ccs0
[417.795648] Dynamic subtest ccs0: SKIP (0.000s)
[417.799989] Subtest busy-check-all: SKIP (0.008s)
[417.836781] [089/133] (608s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[417.947618] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[417.949908] Starting dynamic subtest: pipe-A-eDP-1
[417.969924] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[417.981578] Starting dynamic subtest: pipe-B-eDP-1
[418.000548] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[418.010188] Starting dynamic subtest: pipe-C-eDP-1
[418.029283] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[418.039111] Starting dynamic subtest: pipe-D-eDP-1
[418.058449] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[418.060590] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[420.219749] [090/133] (606s left) prime_busy (before-wait)
[420.279576] Starting subtest: before-wait
[420.281882] Starting dynamic subtest: rcs0
[420.304525] Dynamic subtest rcs0: SUCCESS (0.025s)
[420.316586] Starting dynamic subtest: bcs0
[420.358141] Dynamic subtest bcs0: SUCCESS (0.053s)
[420.369022] Starting dynamic subtest: vcs0
[420.400713] Dynamic subtest vcs0: SUCCESS (0.041s)
[420.410924] Starting dynamic subtest: vcs1
[420.440640] Dynamic subtest vcs1: SUCCESS (0.039s)
[420.449935] Starting dynamic subtest: vecs0
[420.480071] Dynamic subtest vecs0: SUCCESS (0.039s)
[420.489407] Starting dynamic subtest: ccs0
[420.519056] Dynamic subtest ccs0: SUCCESS (0.038s)
[420.628355] Subtest before-wait: SUCCESS (0.350s)
[420.700529] [091/133] (605s left) gem_ppgtt (blt-vs-render-ctx0)
[420.761557] Starting subtest: blt-vs-render-ctx0
[453.632503] Subtest blt-vs-render-ctx0: SUCCESS (32.871s)
[453.786839] [092/133] (572s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[453.949872] Starting subtest: cursorB-vs-flipB-atomic
[453.954174] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[454.094609] [093/133] (572s left) gem_exec_reloc (basic-wc-read-active)
[454.153611] Subtest basic-wc-read-active: SKIP (0.000s)
[454.235771] [094/133] (572s left) gem_exec_fence (syncobj-import)
[454.686012] Starting subtest: syncobj-import
[454.691834] Subtest syncobj-import: SUCCESS (0.005s)
[456.427118] [095/133] (570s left) kms_psr (fbc-psr2-sprite-blt)
[456.547872] Starting subtest: fbc-psr2-sprite-blt
[456.550214] Starting dynamic subtest: eDP-1
[456.554516] Dynamic subtest eDP-1: SKIP (0.000s)
[456.558469] Subtest fbc-psr2-sprite-blt: SKIP (0.003s)
[456.621522] [096/133] (570s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[456.719681] Starting subtest: plane-lut1d-post-ctm3x4
[456.853910] Starting dynamic subtest: pipe-A-plane-0
[457.043596] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[457.054064] Starting dynamic subtest: pipe-A-plane-1
[457.221561] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[457.231717] Starting dynamic subtest: pipe-A-plane-2
[457.354042] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[458.519111] Starting dynamic subtest: pipe-B-plane-0
[458.677606] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[458.688229] Starting dynamic subtest: pipe-B-plane-1
[458.854738] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[458.864790] Starting dynamic subtest: pipe-B-plane-2
[458.987815] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[460.150484] Starting dynamic subtest: pipe-C-plane-0
[460.295903] Dynamic subtest pipe-C-plane-0: SUCCESS (0.156s)
[460.306694] Starting dynamic subtest: pipe-C-plane-1
[460.429004] Dynamic subtest pipe-C-plane-1: SUCCESS (0.132s)
[460.441016] Starting dynamic subtest: pipe-C-plane-2
[460.562612] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[461.782726] Starting dynamic subtest: pipe-D-plane-0
[461.908671] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[461.928627] Starting dynamic subtest: pipe-D-plane-1
[462.052052] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s)
[462.065327] Starting dynamic subtest: pipe-D-plane-2
[462.185042] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s)
[462.470676] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.751s)
[463.357115] [097/133] (563s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[463.420628] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[463.425110] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[463.615843] [098/133] (563s left) kms_big_fb (linear-8bpp-rotate-180)
[463.718248] Starting subtest: linear-8bpp-rotate-180
[464.964696] Subtest linear-8bpp-rotate-180: SUCCESS (1.247s)
[465.089407] [099/133] (561s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[465.179735] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[465.183366] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[465.290606] [100/133] (561s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[465.402185] Starting subtest: extended-modeset-hang-oldfb-with-reset
[465.404196] Starting dynamic subtest: pipe-A
[476.910133] Dynamic subtest pipe-A: SUCCESS (11.505s)
[476.924383] Starting dynamic subtest: pipe-D
[489.193683] Dynamic subtest pipe-D: SUCCESS (12.276s)
[489.196006] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.785s)
[489.994996] [101/133] (536s left) gem_exec_schedule (timeslicing)
[490.087945] Starting subtest: timeslicing
[490.090192] Starting dynamic subtest: rcs0
[490.104893] Dynamic subtest rcs0: SUCCESS (0.023s)
[490.115950] Starting dynamic subtest: bcs0
[490.126472] Dynamic subtest bcs0: SUCCESS (0.021s)
[490.136818] Starting dynamic subtest: vcs0
[490.149396] Dynamic subtest vcs0: SUCCESS (0.022s)
[490.159197] Starting dynamic subtest: vcs1
[490.172558] Dynamic subtest vcs1: SUCCESS (0.021s)
[490.182133] Starting dynamic subtest: vecs0
[490.193436] Dynamic subtest vecs0: SUCCESS (0.020s)
[490.203283] Starting dynamic subtest: ccs0
[490.212812] Dynamic subtest ccs0: SUCCESS (0.019s)
[490.215209] Subtest timeslicing: SUCCESS (0.131s)
[491.408447] [102/133] (535s left) kms_chamelium_color (ctm-0-25)
[491.497447] Subtest ctm-0-25: SKIP (0.000s)
[491.543510] [103/133] (535s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[491.631859] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[491.634089] Starting dynamic subtest: pipe-A-eDP-1
[491.716410] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[491.729233] Starting dynamic subtest: pipe-B-eDP-1
[492.869537] Dynamic subtest pipe-B-eDP-1: SKIP (1.150s)
[492.873774] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.241s)
[494.059319] [104/133] (532s left) gem_mmap (short-mmap)
[494.130186] Subtest short-mmap: SKIP (0.000s)
[494.192720] [105/133] (532s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[494.255929] Starting subtest: multi-wait-available-unsubmitted-submitted
[494.258361] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[494.346401] [106/133] (532s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[494.442600] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[494.446923] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[494.572464] [107/133] (532s left) kms_getfb (getfb2-accept-nv12)
[494.669627] Starting subtest: getfb2-accept-nv12
[494.671931] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[494.787128] [108/133] (532s left) syncobj_timeline (invalid-signal-zero-handles)
[494.843706] Starting subtest: invalid-signal-zero-handles
[494.845906] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[494.942606] [109/133] (532s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[495.045918] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[495.049584] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[495.126858] [110/133] (532s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[495.223744] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[495.225799] Starting dynamic subtest: pipe-A-eDP-1
[495.272799] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[495.282333] Starting dynamic subtest: pipe-B-eDP-1
[495.327926] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[495.338399] Starting dynamic subtest: pipe-C-eDP-1
[495.384754] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[495.394688] Starting dynamic subtest: pipe-D-eDP-1
[495.441341] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[495.444789] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[497.556086] [111/133] (529s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[497.650845] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[497.659325] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[497.738766] [112/133] (529s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[497.825494] Starting subtest: async-flip-with-page-flip-events-tiled
[498.196698] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[501.009047] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.810s)
[501.019706] Starting dynamic subtest: pipe-A-eDP-1-4
[503.183276] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[503.193947] Starting dynamic subtest: pipe-A-eDP-1-4
[505.194373] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[505.204875] Starting dynamic subtest: pipe-A-eDP-1-x
[507.395423] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s)
[507.779385] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[510.546998] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.774s)
[510.560791] Starting dynamic subtest: pipe-B-eDP-1-4
[512.721344] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.173s)
[512.731837] Starting dynamic subtest: pipe-B-eDP-1-4
[514.730893] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[514.741424] Starting dynamic subtest: pipe-B-eDP-1-x
[516.923024] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[517.293787] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[520.081747] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.795s)
[520.092937] Starting dynamic subtest: pipe-C-eDP-1-4
[522.245686] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.162s)
[522.257541] Starting dynamic subtest: pipe-C-eDP-1-4
[524.255880] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[524.266255] Starting dynamic subtest: pipe-C-eDP-1-x
[526.433899] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[526.803436] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[529.606218] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.812s)
[529.617028] Starting dynamic subtest: pipe-D-eDP-1-4
[531.791714] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s)
[531.804994] Starting dynamic subtest: pipe-D-eDP-1-4
[533.801395] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[533.815337] Starting dynamic subtest: pipe-D-eDP-1-x
[535.979949] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[535.982525] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.152s)
[537.183535] [113/133] (490s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[537.279602] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[537.283694] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[537.385206] [114/133] (490s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[537.431250] Starting subtest: etime-multi-wait-for-submit-submitted
[537.540003] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[537.632232] [115/133] (489s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[539.479201] Starting subtest: modeset-non-lpsp-stress-no-wait
[539.529961] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.047s)
[539.919861] [116/133] (487s left) gem_exec_params (sol-reset-invalid)
[539.975207] Starting subtest: sol-reset-invalid
[539.977825] Subtest sol-reset-invalid: SUCCESS (0.002s)
[541.420850] [117/133] (486s left) gem_mmap_gtt (cpuset-big-copy)
[541.481547] Subtest cpuset-big-copy: SKIP (0.000s)
[541.549978] [118/133] (486s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[541.655610] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[549.241390] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.591s)
[549.369444] [119/133] (478s left) kms_psr (psr2-sprite-plane-onoff)
[549.469387] Starting subtest: psr2-sprite-plane-onoff
[549.471648] Starting dynamic subtest: eDP-1
[551.233501] Dynamic subtest eDP-1: SUCCESS (1.765s)
[551.235781] Subtest psr2-sprite-plane-onoff: SUCCESS (1.766s)
[552.098417] [120/133] (475s left) kms_dsc (dsc-with-output-formats)
[552.201809] Starting subtest: dsc-with-output-formats
[552.224764] Subtest dsc-with-output-formats: SKIP (0.000s)
[552.274914] [121/133] (475s left) gen3_mixed_blits
[552.395595] [122/133] (475s left) gem_mmap_offset (clear-via-pagefault)
[552.452142] Starting subtest: clear-via-pagefault
[552.454146] Starting dynamic subtest: smem0
[585.057147] Dynamic subtest smem0: SUCCESS (32.601s)
[585.059115] Subtest clear-via-pagefault: SUCCESS (32.603s)
[585.178738] [123/133] (442s left) gem_eio (reset-stress)
[585.404615] Starting subtest: reset-stress
[585.406733] Starting dynamic subtest: render
[590.424359] Dynamic subtest render: SUCCESS (5.018s)
[590.442084] Starting dynamic subtest: bsd1
[608.864922] Dynamic subtest bsd1: SUCCESS (18.437s)
[608.883423] Starting dynamic subtest: bsd2
[626.916151] Dynamic subtest bsd2: SUCCESS (18.048s)
[626.933263] Starting dynamic subtest: blt
[626.937213] Dynamic subtest blt: SKIP (0.000s)
[626.946903] Starting dynamic subtest: vebox
[644.926515] Dynamic subtest vebox: SUCCESS (18.006s)
[644.929187] Subtest reset-stress: SUCCESS (59.515s)
[646.430411] [124/133] (381s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[646.483410] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[646.485640] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[646.582715] [125/133] (381s left) kms_vblank (query-busy-hang)
[646.674672] Starting subtest: query-busy-hang
[646.676638] Starting dynamic subtest: pipe-A-eDP-1
[648.550547] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[648.565518] Starting dynamic subtest: pipe-D-eDP-1
[651.138056] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.584s)
[651.140468] Subtest query-busy-hang: SUCCESS (4.464s)
[651.946885] [126/133] (376s left) kms_psr (fbc-pr-cursor-plane-onoff)
[652.039768] Starting subtest: fbc-pr-cursor-plane-onoff
[652.044011] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[652.109654] [127/133] (375s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[652.220175] Starting subtest: psr-1p-primscrn-cur-indfb-move
[659.566289] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.350s)
[659.719237] [128/133] (368s left) tools_test (sysfs_l3_parity)
[659.779882] Starting subtest: sysfs_l3_parity
[659.837161] Subtest sysfs_l3_parity: SKIP (0.070s)
[659.892775] [129/133] (368s left) kms_vblank (crtc-id)
[659.983745] Starting subtest: crtc-id
[659.986227] Starting dynamic subtest: pipe-A-eDP-1
[660.426747] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[660.443240] Starting dynamic subtest: pipe-D-eDP-1
[661.584378] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.155s)
[661.586716] Subtest crtc-id: SUCCESS (1.601s)
[662.430128] [130/133] (365s left) gem_ctx_engines (independent)
[662.498797] Starting subtest: independent
[662.500749] Starting dynamic subtest: rcs0
[662.653259] Dynamic subtest rcs0: SUCCESS (0.156s)
[662.664356] Starting dynamic subtest: bcs0
[662.816976] Dynamic subtest bcs0: SUCCESS (0.163s)
[662.828006] Starting dynamic subtest: vcs0
[662.977428] Dynamic subtest vcs0: SUCCESS (0.159s)
[662.990663] Starting dynamic subtest: vcs1
[663.141931] Dynamic subtest vcs1: SUCCESS (0.164s)
[663.154417] Starting dynamic subtest: vecs0
[663.291785] Dynamic subtest vecs0: SUCCESS (0.149s)
[663.304625] Starting dynamic subtest: ccs0
[663.463648] Dynamic subtest ccs0: SUCCESS (0.171s)
[663.476143] Starting dynamic subtest: all-engines
[664.193271] Dynamic subtest all-engines: SUCCESS (0.729s)
[664.195801] Subtest independent: SUCCESS (1.698s)
[664.594237] [131/133] (363s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[664.689043] Starting subtest: flip-vs-dpms-on-nop-interruptible
[664.691466] Starting dynamic subtest: A-eDP1
[666.525409] Dynamic subtest A-eDP1: SUCCESS (1.836s)
[666.538975] Starting dynamic subtest: B-eDP1
[668.358542] Dynamic subtest B-eDP1: SUCCESS (1.830s)
[668.371651] Starting dynamic subtest: C-eDP1
[670.171522] Dynamic subtest C-eDP1: SUCCESS (1.810s)
[670.188600] Starting dynamic subtest: D-eDP1
[671.996006] Dynamic subtest D-eDP1: SUCCESS (1.821s)
[671.998396] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.310s)
[673.173551] [132/133] (355s left) kms_plane_lowres (tiling-x)
[673.283629] Starting subtest: tiling-x
[673.285997] Starting dynamic subtest: pipe-A-eDP-1
[673.290651] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[673.596275] Starting dynamic subtest: pipe-B-eDP-1
[673.600981] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[673.611562] Starting dynamic subtest: pipe-C-eDP-1
[673.616208] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[673.626647] Starting dynamic subtest: pipe-D-eDP-1
[673.631101] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[673.635539] Subtest tiling-x: SKIP (0.305s)
[674.398647] [133/133] (353s left) i915_pm_freq_api (freq-reset)
[674.457171] Starting subtest: freq-reset
[674.459731] Starting dynamic subtest: gt0
[674.650402] Dynamic subtest gt0: SUCCESS (0.193s)
[674.662555] Starting dynamic subtest: gt1
[674.825343] Dynamic subtest gt1: SUCCESS (0.169s)
[674.828155] Subtest freq-reset: SUCCESS (0.364s)
[674.895914] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gen7_exec_parse
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: tools_test
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: i915_pm_rpm
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: drm_read
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_chamelium_edid
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_rotation_crc
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: vgem_basic
results: parsing output: 32/ for test: kms_atomic_interruptible
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: gem_exec_basic
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_joiner
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: i915_query
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: dumb_buffer
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: gem_blits
results: parsing output: 48/ for test: gem_busy
results: parsing output: 49/ for test: gem_exec_alignment
results: parsing output: 50/ for test: syncobj_eventfd
results: parsing output: 51/ for test: prime_mmap
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: gem_ctx_param
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_cursor_edge_walk
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_vm_create
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: vgem_basic
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_pread
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 79/ for test: kms_pm_backlight
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_dp_linktrain_fallback
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: prime_busy
results: parsing output: 90/ for test: gem_ppgtt
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_color_pipeline
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_busy
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_chamelium_color
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: gem_mmap
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_dsc
results: parsing output: 120/ for test: gen3_mixed_blits
results: parsing output: 121/ for test: gem_mmap_offset
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: tools_test
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: gem_ctx_engines
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_plane_lowres
results: parsing output: 132/ for test: i915_pm_freq_api
Done.