[91.199035] Initializing watchdogs
[91.199095]   /dev/watchdog0
[91.214211] [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]
[91.218594] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.221190] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.224501] [001/133] (960s left) kms_cursor_crc (cursor-suspend)
[91.387715] Starting subtest: cursor-suspend
[91.390047] Starting dynamic subtest: pipe-A-eDP-1
[123.786095] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.308s)
[123.796252] Starting dynamic subtest: pipe-D-eDP-1
[157.808328] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.818s)
[157.810640] Subtest cursor-suspend: SUCCESS (7.128s)
[158.648851] [002/133] (893s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[158.739329] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[158.741619] Starting dynamic subtest: pipe-A-eDP-1
[158.764980] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[158.775568] Starting dynamic subtest: pipe-B-eDP-1
[158.796707] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[158.804551] Starting dynamic subtest: pipe-C-eDP-1
[158.825680] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[158.833174] Starting dynamic subtest: pipe-D-eDP-1
[158.855357] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[158.859820] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[161.029700] [003/133] (890s left) gem_ctx_create (basic-files)
[161.105595] Starting subtest: basic-files
[163.113430] Subtest basic-files: SUCCESS (2.000s)
[163.430500] [004/133] (888s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[163.546647] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[195.110246] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.530s)
[195.985686] [005/133] (855s left) kms_dsc (dsc-fractional-bpp)
[196.074601] Starting subtest: dsc-fractional-bpp
[196.087576] Subtest dsc-fractional-bpp: SKIP (0.000s)
[196.161020] [006/133] (855s left) gem_eio (wait-10ms)
[196.397597] Starting subtest: wait-10ms
[196.790080] Subtest wait-10ms: SUCCESS (0.393s)
[196.943907] [007/133] (855s left) kms_psr (fbc-psr2-no-drrs)
[197.042335] Starting subtest: fbc-psr2-no-drrs
[197.044786] Starting dynamic subtest: eDP-1
[197.049246] Dynamic subtest eDP-1: SKIP (0.000s)
[197.053736] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[197.120893] [008/133] (854s left) sriov_basic (bind-unbind-vf)
[197.177719] Starting subtest: bind-unbind-vf
[197.179953] Starting dynamic subtest: vf-1
[197.251590] Dynamic subtest vf-1: FAIL (0.017s)
[197.260313] Starting dynamic subtest: vf-2
[197.342194] Dynamic subtest vf-2: FAIL (0.004s)
[197.353456] Starting dynamic subtest: vf-3
[197.422660] Dynamic subtest vf-3: FAIL (0.004s)
[197.431177] Starting dynamic subtest: vf-4
[197.500119] Dynamic subtest vf-4: FAIL (0.004s)
[197.508599] Starting dynamic subtest: vf-5
[197.567399] Dynamic subtest vf-5: FAIL (0.004s)
[197.575045] Starting dynamic subtest: vf-6
[197.631748] Dynamic subtest vf-6: FAIL (0.004s)
[197.639608] Starting dynamic subtest: vf-7
[197.699446] Dynamic subtest vf-7: FAIL (0.004s)
[197.709431] Starting dynamic subtest: vf-random
[197.770304] Dynamic subtest vf-random: FAIL (0.004s)
[197.779150] Starting dynamic subtest: vf-last
[197.839668] Dynamic subtest vf-last: FAIL (0.463s)
[197.841383] Subtest bind-unbind-vf: FAIL (0.510s)
[197.876167] [009/133] (854s left) syncobj_basic (test-valid-cycle)
[197.932658] Starting subtest: test-valid-cycle
[197.934553] Subtest test-valid-cycle: SUCCESS (0.000s)
[198.019455] [010/133] (854s left) kms_psr (psr2-sprite-mmap-gtt)
[198.112596] Starting subtest: psr2-sprite-mmap-gtt
[198.114632] Starting dynamic subtest: eDP-1
[199.510455] Dynamic subtest eDP-1: SKIP (1.395s)
[199.515191] Subtest psr2-sprite-mmap-gtt: SKIP (1.396s)
[199.702996] [011/133] (852s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[199.801520] Starting subtest: fbcpsr-tiling-linear
[206.455646] Subtest fbcpsr-tiling-linear: SUCCESS (6.657s)
[206.566748] [012/133] (845s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[206.627467] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[206.732850] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[206.806793] [013/133] (845s left) gem_exec_schedule (semaphore-power)
[206.993280] Subtest semaphore-power: SKIP (0.000s)
[207.169090] [014/133] (845s left) kms_big_fb (linear-16bpp-rotate-0)
[207.271295] Starting subtest: linear-16bpp-rotate-0
[208.638169] Subtest linear-16bpp-rotate-0: SUCCESS (1.367s)
[208.760633] [015/133] (843s left) gem_render_copy (linear-to-vebox-yf-tiled)
[208.822588] Starting subtest: linear-to-vebox-yf-tiled
[208.826465] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[209.010908] [016/133] (843s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[209.109136] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[209.120207] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[209.218895] [017/133] (843s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[209.498407] Starting subtest: cursor-rapid-movement-512x512
[209.502417] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[209.669948] [018/133] (842s left) gem_create (busy-create)
[209.724005] Starting subtest: busy-create
[209.726297] Starting dynamic subtest: smem0
[243.155105] Dynamic subtest smem0: SUCCESS (33.420s)
[243.158034] Subtest busy-create: SUCCESS (33.421s)
[243.334712] [019/133] (809s left) i915_suspend (basic-s3-without-i915)
[243.374160] Starting subtest: basic-s3-without-i915
[246.712882] Subtest basic-s3-without-i915: SKIP (3.332s)
[248.317771] [020/133] (804s left) gem_ctx_param (vm)
[248.386461] Starting subtest: vm
[248.441296] Subtest vm: SUCCESS (0.055s)
[248.567748] [021/133] (803s left) perf_pmu (init-sema)
[248.604113] Starting subtest: init-sema
[248.606424] Starting dynamic subtest: rcs0
[248.608722] Dynamic subtest rcs0: SUCCESS (0.002s)
[248.617590] Starting dynamic subtest: bcs0
[248.619507] Dynamic subtest bcs0: SUCCESS (0.000s)
[248.626934] Starting dynamic subtest: vcs0
[248.628874] Dynamic subtest vcs0: SUCCESS (0.001s)
[248.636341] Starting dynamic subtest: vcs1
[248.638344] Dynamic subtest vcs1: SUCCESS (0.000s)
[248.646287] Starting dynamic subtest: vecs0
[248.648465] Dynamic subtest vecs0: SUCCESS (0.001s)
[248.657097] Starting dynamic subtest: ccs0
[248.659300] Dynamic subtest ccs0: SUCCESS (0.000s)
[248.661496] Subtest init-sema: SUCCESS (0.006s)
[248.731694] [022/133] (803s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[248.849818] Starting subtest: short-flip-before-cursor-atomic-transitions
[249.846134] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.996s)
[250.730765] [023/133] (801s left) gem_flink_basic (bad-open)
[250.780704] Starting subtest: bad-open
[250.782676] Subtest bad-open: SUCCESS (0.000s)
[250.879926] [024/133] (801s left) gem_lmem_swapping (parallel-random-verify-ccs)
[250.920868] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[250.962728] [025/133] (801s left) kms_plane_scaling (invalid-num-scalers)
[251.067463] Starting subtest: invalid-num-scalers
[251.069767] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[251.087800] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.020s)
[251.095960] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[251.127151] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.038s)
[251.135086] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[251.166403] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.038s)
[251.174569] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[251.206101] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.039s)
[251.208454] Subtest invalid-num-scalers: SUCCESS (0.139s)
[251.327510] [026/133] (801s left) vgem_basic (sysfs)
[251.391097] Starting subtest: sysfs
[251.393149] Subtest sysfs: SUCCESS (0.000s)
[251.442451] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[251.445805] [027/133] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[251.557167] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[258.261926] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.709s)
[258.382238] [028/133] (794s left) gem_exec_schedule (preempt-queue)
[258.463910] Subtest preempt-queue: SKIP (0.000s)
[258.744559] [029/133] (794s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[258.838210] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[262.682795] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.850s)
[263.820554] [030/133] (789s left) i915_pm_rps (reset)
[263.881177] Starting subtest: reset
[272.351616] Subtest reset: SUCCESS (8.446s)
[272.454016] [031/133] (780s left) gem_exec_whisper (basic-contexts-forked-all)
[272.513094] Starting subtest: basic-contexts-forked-all
[297.026126] Subtest basic-contexts-forked-all: SUCCESS (24.508s)
[297.213553] [032/133] (755s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[297.324787] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[297.329893] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[297.418667] [033/133] (755s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[297.478528] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[297.542864] [034/133] (755s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[297.630731] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[297.634658] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[297.728142] [035/133] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[297.829796] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[297.834086] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[297.934406] [036/133] (755s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[298.023372] Starting subtest: 2x-flip-vs-modeset-vs-hang
[298.034728] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[298.115102] [037/133] (755s left) vgem_basic (bad-pad)
[298.156469] Starting subtest: bad-pad
[298.158399] Subtest bad-pad: SUCCESS (0.000s)
[298.213621] [038/133] (754s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[298.306206] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[302.517809] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.213s)
[303.727996] [039/133] (749s left) gen9_exec_parse (unaligned-access)
[303.799578] Subtest unaligned-access: SKIP (0.000s)
[303.872397] [040/133] (749s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[303.967979] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[310.948153] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.981s)
[311.084280] [041/133] (742s left) gem_caching (read-writes)
[311.145032] Subtest read-writes: SKIP (0.000s)
[311.219464] [042/133] (742s left) kms_frontbuffer_tracking (fbc-2p-rte)
[311.315315] Starting subtest: fbc-2p-rte
[311.319697] Subtest fbc-2p-rte: SKIP (0.000s)
[311.417479] [043/133] (741s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[311.482895] Starting subtest: y-tiled-ccs-to-yf-tiled
[311.487583] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[311.701883] [044/133] (741s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[311.790996] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[311.795689] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[311.888262] [045/133] (741s left) gem_lmem_swapping (heavy-verify-random)
[311.932674] Subtest heavy-verify-random: SKIP (0.000s)
[311.984203] [046/133] (741s left) kms_plane_alpha_blend (alpha-opaque-fb)
[312.074622] Starting subtest: alpha-opaque-fb
[312.370066] Starting dynamic subtest: pipe-A-eDP-1
[313.058159] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s)
[313.069077] Starting dynamic subtest: pipe-D-eDP-1
[314.403757] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[314.406146] Subtest alpha-opaque-fb: SUCCESS (2.331s)
[315.208243] [047/133] (738s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[315.315272] Starting subtest: x-tiled-64bpp-rotate-270
[315.335044] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[315.450871] [048/133] (738s left) kms_sequence (get-forked-busy)
[315.546929] Starting subtest: get-forked-busy
[315.549199] Starting dynamic subtest: pipe-A-eDP-1
[317.482210] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[317.492891] Starting dynamic subtest: pipe-B-eDP-1
[320.112345] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.628s)
[320.122116] Starting dynamic subtest: pipe-C-eDP-1
[322.719165] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.607s)
[322.729940] Starting dynamic subtest: pipe-D-eDP-1
[325.266727] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s)
[325.268941] Subtest get-forked-busy: SUCCESS (9.718s)
[326.072723] [049/133] (727s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[326.172341] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[326.176457] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[326.241672] [050/133] (727s left) kms_cursor_crc (cursor-size-change)
[326.351372] Starting subtest: cursor-size-change
[326.353585] Starting dynamic subtest: pipe-A-eDP-1
[327.155715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.801s)
[327.166378] Starting dynamic subtest: pipe-D-eDP-1
[328.655156] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.500s)
[328.657548] Subtest cursor-size-change: SUCCESS (2.304s)
[329.539297] [051/133] (724s left) syncobj_wait (single-wait-for-submit-signaled)
[329.594631] Starting subtest: single-wait-for-submit-signaled
[329.596893] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[329.686943] [052/133] (724s left) perf (non-system-wide-paranoid)
[329.806798] Starting subtest: non-system-wide-paranoid
[329.837567] Subtest non-system-wide-paranoid: SUCCESS (0.031s)
[329.886663] [053/133] (723s left) i915_hangman (gt-engine-hang)
[329.941125] Starting subtest: gt-engine-hang
[329.943282] Starting dynamic subtest: rcs0
[331.128376] Dynamic subtest rcs0: SUCCESS (1.186s)
[331.145132] Starting dynamic subtest: bcs0
[333.109400] Dynamic subtest bcs0: SUCCESS (1.978s)
[333.122020] Starting dynamic subtest: vcs0
[335.094892] Dynamic subtest vcs0: SUCCESS (1.982s)
[335.107508] Starting dynamic subtest: vcs1
[337.143270] Dynamic subtest vcs1: SUCCESS (2.045s)
[337.159973] Starting dynamic subtest: vecs0
[339.127395] Dynamic subtest vecs0: SUCCESS (1.981s)
[339.140437] Starting dynamic subtest: ccs0
[341.113268] Dynamic subtest ccs0: SUCCESS (1.983s)
[341.116089] Subtest gt-engine-hang: SUCCESS (11.170s)
[341.272423] [054/133] (712s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[341.375199] Starting subtest: 4-tiled-64bpp-rotate-270
[341.395568] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[341.514750] [055/133] (712s left) api_intel_allocator (standalone)
[341.563579] Starting subtest: standalone
[341.578059] Subtest standalone: SUCCESS (0.017s)
[341.699059] [056/133] (712s left) gem_ctx_sseu (invalid-sseu)
[341.754007] Subtest invalid-sseu: SKIP (0.000s)
[341.808963] [057/133] (712s left) kms_force_connector_basic (force-edid)
[341.879595] Starting subtest: force-edid
[342.247978] Subtest force-edid: SUCCESS (0.368s)
[342.391348] [058/133] (711s left) gem_exec_fence (syncobj-repeat)
[342.911812] Starting subtest: syncobj-repeat
[343.107837] Subtest syncobj-repeat: SUCCESS (0.195s)
[344.224660] [059/133] (709s left) kms_chamelium_hpd (common-hpd-after-suspend)
[344.604252] Subtest common-hpd-after-suspend: SKIP (0.000s)
[345.446288] [060/133] (708s left) kms_chamelium_frames (hdmi-crc-single)
[345.822152] Subtest hdmi-crc-single: SKIP (0.000s)
[346.632932] [061/133] (707s left) gem_mmap_gtt (big-copy)
[346.684481] Subtest big-copy: SKIP (0.000s)
[346.751129] [062/133] (707s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[346.843700] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[346.845892] Starting dynamic subtest: pipe-A-eDP-1
[346.868907] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[346.881315] Starting dynamic subtest: pipe-B-eDP-1
[346.902731] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[346.911628] Starting dynamic subtest: pipe-C-eDP-1
[346.932941] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[346.942203] Starting dynamic subtest: pipe-D-eDP-1
[346.965331] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[346.969555] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[349.079912] [063/133] (705s left) gen7_exec_parse (bitmasks)
[349.134507] Subtest bitmasks: SKIP (0.000s)
[349.210537] [064/133] (705s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[349.309732] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[349.314089] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[349.393721] [065/133] (704s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[349.496263] Starting subtest: fbcpsr-modesetfrombusy
[355.688107] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.195s)
[355.819007] [066/133] (698s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[355.930129] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[355.932105] Starting dynamic subtest: pipe-A-eDP-1
[355.951014] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[355.963770] Starting dynamic subtest: pipe-B-eDP-1
[355.981164] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[355.990167] Starting dynamic subtest: pipe-C-eDP-1
[356.008064] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[356.017476] Starting dynamic subtest: pipe-D-eDP-1
[356.035151] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[356.038696] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[358.161273] [067/133] (696s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[358.260657] Starting subtest: plane-upscale-factor-0-25-with-rotation
[358.262767] Starting dynamic subtest: pipe-A
[358.485931] Dynamic subtest pipe-A: SUCCESS (0.227s)
[358.498380] Starting dynamic subtest: pipe-B
[359.813387] Dynamic subtest pipe-B: SUCCESS (1.326s)
[359.822834] Starting dynamic subtest: pipe-C
[361.112432] Dynamic subtest pipe-C: SUCCESS (1.298s)
[361.122883] Starting dynamic subtest: pipe-D
[362.408806] Dynamic subtest pipe-D: SUCCESS (1.294s)
[362.411146] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.149s)
[363.569376] [068/133] (690s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[363.679327] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[363.683916] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[363.781760] [069/133] (690s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[363.837652] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[363.839958] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[363.933781] [070/133] (690s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[364.021724] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[364.025832] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[364.129716] [071/133] (690s left) kms_scaling_modes (scaling-mode-full-aspect)
[364.213446] Starting subtest: scaling-mode-full-aspect
[364.215664] Starting dynamic subtest: pipe-A-eDP-1
[364.305769] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[364.316358] Starting dynamic subtest: pipe-B-eDP-1
[365.457476] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.150s)
[365.467742] Starting dynamic subtest: pipe-C-eDP-1
[366.632909] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.173s)
[366.644505] Starting dynamic subtest: pipe-D-eDP-1
[367.755985] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[367.758286] Subtest scaling-mode-full-aspect: SUCCESS (3.545s)
[368.980153] [072/133] (685s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[369.079858] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[375.568824] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.489s)
[375.695214] [073/133] (678s left) kms_prop_blob (blob-multiple)
[375.747246] Starting subtest: blob-multiple
[375.749625] Subtest blob-multiple: SUCCESS (0.002s)
[375.843393] [074/133] (678s left) perf_pmu (interrupts-sync)
[375.887186] Starting subtest: interrupts-sync
[377.003722] Subtest interrupts-sync: SUCCESS (1.114s)
[377.115173] [075/133] (677s left) kms_psr (psr2-cursor-mmap-cpu)
[377.217709] Starting subtest: psr2-cursor-mmap-cpu
[377.220041] Starting dynamic subtest: eDP-1
[378.912026] Dynamic subtest eDP-1: SUCCESS (1.692s)
[378.914240] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.693s)
[379.763240] [076/133] (675s left) api_intel_bb (intel-bb-blit-y)
[379.824395] Starting subtest: intel-bb-blit-y
[383.236988] Subtest intel-bb-blit-y: SUCCESS (3.414s)
[383.381807] [077/133] (671s left) gem_softpin (allocator-nopin)
[383.438960] Starting subtest: allocator-nopin
[383.531474] Subtest allocator-nopin: SUCCESS (0.091s)
[383.680619] [078/133] (671s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[383.787634] Starting subtest: psr-modesetfrombusy
[389.976945] Subtest psr-modesetfrombusy: SUCCESS (6.194s)
[390.119263] [079/133] (664s left) syncobj_basic (bad-flags-fd-to-handle)
[390.178279] Starting subtest: bad-flags-fd-to-handle
[390.180553] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[390.279032] [080/133] (664s left) kms_atomic (plane-invalid-params)
[390.373204] Starting subtest: plane-invalid-params
[390.375185] Starting dynamic subtest: pipe-A-eDP-1
[390.784114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s)
[390.786362] Subtest plane-invalid-params: SUCCESS (0.411s)
[391.667909] [081/133] (663s left) gen3_render_linear_blits
[391.790809] [082/133] (663s left) gem_ctx_persistence (legacy-engines-hang)
[391.843271] Starting subtest: legacy-engines-hang
[391.845890] Starting dynamic subtest: render
[391.956405] Dynamic subtest render: SUCCESS (0.112s)
[391.969090] Starting dynamic subtest: bsd1
[392.044696] Dynamic subtest bsd1: SUCCESS (0.086s)
[392.059000] Starting dynamic subtest: bsd2
[392.134540] Dynamic subtest bsd2: SUCCESS (0.087s)
[392.148257] Starting dynamic subtest: blt
[392.242318] Dynamic subtest blt: SUCCESS (0.105s)
[392.256131] Starting dynamic subtest: vebox
[392.344404] Dynamic subtest vebox: SUCCESS (0.098s)
[392.346965] Subtest legacy-engines-hang: SUCCESS (0.503s)
[392.431739] [083/133] (662s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[392.533379] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[393.655689] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.124s)
[393.770109] [084/133] (661s left) kms_psr (fbc-psr2-suspend)
[393.864477] Starting subtest: fbc-psr2-suspend
[393.866535] Starting dynamic subtest: eDP-1
[393.870212] Dynamic subtest eDP-1: SKIP (0.000s)
[393.873878] Subtest fbc-psr2-suspend: SKIP (0.001s)
[393.937322] [085/133] (661s left) gem_linear_blits (basic)
[394.463583] Starting subtest: basic
[394.473630] Subtest basic: SUCCESS (0.010s)
[394.636389] [086/133] (660s left) kms_legacy_colorkey (basic)
[394.791362] Starting subtest: basic
[394.793258] Starting dynamic subtest: pipe-A
[394.834507] Dynamic subtest pipe-A: SUCCESS (0.045s)
[394.850278] Starting dynamic subtest: pipe-B
[394.852568] Dynamic subtest pipe-B: SUCCESS (0.000s)
[394.861789] Starting dynamic subtest: pipe-C
[394.863623] Dynamic subtest pipe-C: SUCCESS (0.000s)
[394.872450] Starting dynamic subtest: pipe-D
[394.874317] Dynamic subtest pipe-D: SUCCESS (0.000s)
[394.876195] Subtest basic: SUCCESS (0.050s)
[394.912723] [087/133] (660s left) gem_busy (semaphore)
[395.097798] Subtest semaphore: SKIP (0.000s)
[395.321252] [088/133] (660s left) prime_mmap (test_reprime)
[395.374570] Starting subtest: test_reprime
[395.376459] Starting dynamic subtest: test_reprime-smem
[395.403740] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[395.406170] Subtest test_reprime: SUCCESS (0.032s)
[395.498607] [089/133] (659s left) gem_readwrite (new-obj)
[395.547115] Subtest new-obj: SKIP (0.000s)
[395.606779] [090/133] (659s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[395.702581] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[395.706896] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[395.802168] [091/133] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[395.892051] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[395.896140] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[396.009602] [092/133] (659s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[396.119285] Starting subtest: pr-primary-plane-update-sf-dmg-area
[396.123594] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[396.206336] [093/133] (659s left) gem_exec_schedule (implicit-boths)
[396.283332] Starting subtest: implicit-boths
[396.285101] Starting dynamic subtest: rcs0
[396.381368] Dynamic subtest rcs0: SUCCESS (0.105s)
[396.393705] Starting dynamic subtest: vcs0
[396.463222] Dynamic subtest vcs0: SUCCESS (0.081s)
[396.475986] Starting dynamic subtest: vcs1
[396.544848] Dynamic subtest vcs1: SUCCESS (0.081s)
[396.558135] Starting dynamic subtest: vecs0
[396.646368] Dynamic subtest vecs0: SUCCESS (0.101s)
[396.660063] Starting dynamic subtest: ccs0
[396.751838] Dynamic subtest ccs0: SUCCESS (0.104s)
[396.754215] Subtest implicit-boths: SUCCESS (0.476s)
[398.257212] [094/133] (657s left) kms_invalid_mode (zero-vdisplay)
[398.356190] Starting subtest: zero-vdisplay
[398.358559] Starting dynamic subtest: pipe-A-eDP-1
[398.641715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[398.652580] Starting dynamic subtest: pipe-B-eDP-1
[398.655067] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[398.664721] Starting dynamic subtest: pipe-C-eDP-1
[398.666636] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[398.675494] Starting dynamic subtest: pipe-D-eDP-1
[398.677530] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[398.679917] Subtest zero-vdisplay: SUCCESS (0.292s)
[399.466029] [095/133] (656s left) syncobj_timeline (single-wait-all-signaled)
[399.534582] Starting subtest: single-wait-all-signaled
[399.537201] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[399.639142] [096/133] (656s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[399.748408] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[399.752805] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[399.859737] [097/133] (655s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[400.119883] Starting subtest: parallel-dmabuf-import-out-fence
[401.266090] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.146s)
[401.391991] [098/133] (654s left) gem_softpin (evict-active)
[401.454916] Starting subtest: evict-active
[401.461791] Subtest evict-active: SUCCESS (0.007s)
[401.572889] [099/133] (654s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[401.668569] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[401.670858] Starting dynamic subtest: pipe-A-eDP-1
[401.692952] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[401.703560] Starting dynamic subtest: pipe-B-eDP-1
[401.722685] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[401.732117] Starting dynamic subtest: pipe-C-eDP-1
[401.752600] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[401.762036] Starting dynamic subtest: pipe-D-eDP-1
[401.783140] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[401.787263] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.005s)
[403.960931] [100/133] (651s left) syncobj_eventfd (timeline-wait)
[404.016092] Starting subtest: timeline-wait
[404.024634] Subtest timeline-wait: SUCCESS (0.011s)
[404.114919] [101/133] (651s left) dumb_buffer (map-invalid-size)
[404.173333] Starting subtest: map-invalid-size
[404.175606] Subtest map-invalid-size: SUCCESS (0.000s)
[404.288505] [102/133] (651s left) kms_plane (pixel-format-4-tiled-modifier)
[404.386296] Starting subtest: pixel-format-4-tiled-modifier
[404.413056] Starting dynamic subtest: pipe-A-plane-0
[405.112425] Dynamic subtest pipe-A-plane-0: SUCCESS (0.700s)
[405.124499] Starting dynamic subtest: pipe-A-plane-3
[405.568010] Dynamic subtest pipe-A-plane-3: SUCCESS (0.453s)
[405.578372] Starting dynamic subtest: pipe-A-plane-5
[405.581872] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[406.710972] Starting dynamic subtest: pipe-B-plane-0
[407.402167] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s)
[407.412497] Starting dynamic subtest: pipe-B-plane-3
[407.846135] Dynamic subtest pipe-B-plane-3: SUCCESS (0.443s)
[407.856043] Starting dynamic subtest: pipe-B-plane-5
[407.859593] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[408.164344] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.780s)
[408.964212] [103/133] (647s left) kms_content_protection (type1)
[409.102592] Starting subtest: type1
[409.107220] Subtest type1: SKIP (0.000s)
[409.229937] [104/133] (646s left) gem_basic (create-close)
[409.282581] Starting subtest: create-close
[409.286830] Subtest create-close: SUCCESS (0.000s)
[409.367851] [105/133] (646s left) syncobj_timeline (invalid-wait-bad-flags)
[409.433601] Starting subtest: invalid-wait-bad-flags
[409.435921] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[409.528620] [106/133] (646s left) kms_chamelium_audio (hdmi-audio-edid)
[409.906327] Subtest hdmi-audio-edid: SKIP (0.000s)
[410.738902] [107/133] (645s left) kms_plane_multiple (tiling-y)
[410.836754] Starting subtest: tiling-y
[410.841077] Subtest tiling-y: SKIP (0.000s)
[410.911463] [108/133] (645s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[411.006331] Starting subtest: plane-lut1d-pre-ctm3x4
[411.152722] Starting dynamic subtest: pipe-A-plane-0
[411.508475] Dynamic subtest pipe-A-plane-0: FAIL (0.181s)
[411.521131] Starting dynamic subtest: pipe-A-plane-1
[411.734596] Dynamic subtest pipe-A-plane-1: FAIL (0.181s)
[411.747551] Starting dynamic subtest: pipe-A-plane-2
[411.952995] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[412.848486] Starting dynamic subtest: pipe-B-plane-0
[413.283216] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[413.295567] Starting dynamic subtest: pipe-B-plane-1
[413.606950] Dynamic subtest pipe-B-plane-1: FAIL (0.211s)
[413.618848] Starting dynamic subtest: pipe-B-plane-2
[413.915170] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[414.621952] Starting dynamic subtest: pipe-C-plane-0
[415.110036] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[415.123383] Starting dynamic subtest: pipe-C-plane-1
[415.524978] Dynamic subtest pipe-C-plane-1: FAIL (0.614s)
[415.537008] Starting dynamic subtest: pipe-C-plane-2
[415.900145] Dynamic subtest pipe-C-plane-2: FAIL (0.171s)
[416.736690] Starting dynamic subtest: pipe-D-plane-0
[417.343139] Dynamic subtest pipe-D-plane-0: FAIL (0.163s)
[417.354065] Starting dynamic subtest: pipe-D-plane-1
[417.805995] Dynamic subtest pipe-D-plane-1: FAIL (0.611s)
[417.817214] Starting dynamic subtest: pipe-D-plane-2
[418.256234] Dynamic subtest pipe-D-plane-2: FAIL (0.562s)
[418.364071] Subtest plane-lut1d-pre-ctm3x4: FAIL (7.359s)
[419.161416] [109/133] (637s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[419.259569] Starting subtest: primary-yf-tiled-reflect-x-0
[419.319387] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[419.423100] [110/133] (636s left) sw_sync (sync_multi_timeline_wait)
[419.462314] Starting subtest: sync_multi_timeline_wait
[419.464674] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[419.525792] [111/133] (636s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[419.580036] Starting subtest: multi-wait-for-submit-available-signaled
[419.582342] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[419.679117] [112/133] (636s left) perf (global-sseu-config)
[419.793595] Starting subtest: global-sseu-config
[419.798082] Subtest global-sseu-config: SKIP (0.000s)
[419.838859] [113/133] (636s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[419.949953] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[419.954559] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[420.096280] [114/133] (636s left) gem_basic (bad-close)
[420.152012] Starting subtest: bad-close
[420.155402] Subtest bad-close: SUCCESS (0.000s)
[420.242608] [115/133] (636s left) gem_mmap_offset (oob-read)
[420.306436] Starting subtest: oob-read
[420.308449] Subtest oob-read: SUCCESS (0.000s)
[420.417385] [116/133] (636s left) syncobj_basic (bad-destroy)
[420.469892] Starting subtest: bad-destroy
[420.471992] Subtest bad-destroy: SUCCESS (0.000s)
[420.588693] [117/133] (636s left) kms_async_flips (alternate-sync-async-flip)
[420.687574] Starting subtest: alternate-sync-async-flip
[421.074758] Starting dynamic subtest: pipe-A-eDP-1
[423.824471] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.751s)
[424.221440] Starting dynamic subtest: pipe-B-eDP-1
[427.018844] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.809s)
[427.403331] Starting dynamic subtest: pipe-C-eDP-1
[430.211785] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.823s)
[430.575784] Starting dynamic subtest: pipe-D-eDP-1
[433.321552] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.754s)
[433.323815] Subtest alternate-sync-async-flip: SUCCESS (12.636s)
[434.550268] [118/133] (622s left) gem_pread (uncached)
[434.615850] Subtest uncached: SKIP (0.000s)
[434.673294] [119/133] (622s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[434.771238] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[457.581892] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.813s)
[457.710043] [120/133] (599s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[457.808677] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[457.812216] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[457.905952] [121/133] (598s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[458.028915] Starting subtest: flip-vs-cursor-legacy
[465.201060] Subtest flip-vs-cursor-legacy: SUCCESS (7.168s)
[466.048039] [122/133] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[466.160558] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[466.164643] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[466.259589] [123/133] (590s left) kms_pm_dc (dc6-dpms)
[467.354226] Starting subtest: dc6-dpms
[469.392801] Subtest dc6-dpms: SUCCESS (2.036s)
[469.472605] [124/133] (587s left) kms_vblank (wait-idle-hang)
[469.571953] Starting subtest: wait-idle-hang
[469.573912] Starting dynamic subtest: pipe-A-eDP-1
[495.968975] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.393s)
[495.986209] Starting dynamic subtest: pipe-D-eDP-1
[520.940473] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.964s)
[520.942333] Subtest wait-idle-hang: SUCCESS (51.361s)
[521.752084] [125/133] (535s left) kms_rotation_crc (sprite-rotation-90)
[521.847989] Starting subtest: sprite-rotation-90
[521.852294] Subtest sprite-rotation-90: SKIP (0.001s)
[521.923710] [126/133] (535s left) gem_exec_balancer (bonded-true-hang)
[522.178265] Starting subtest: bonded-true-hang
[522.183590] Subtest bonded-true-hang: SKIP (0.000s)
[522.275463] [127/133] (534s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[522.399126] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[522.532189] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.135s)
[522.655900] [128/133] (534s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[522.754801] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[522.758911] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[522.841620] [129/133] (534s left) kms_cursor_crc (cursor-offscreen-64x64)
[523.023295] Starting subtest: cursor-offscreen-64x64
[523.028590] Starting dynamic subtest: pipe-A-eDP-1
[524.968095] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s)
[524.997462] Starting dynamic subtest: pipe-D-eDP-1
[527.543739] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[527.546221] Subtest cursor-offscreen-64x64: SUCCESS (4.520s)
[528.352497] [130/133] (528s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[528.466950] Starting subtest: flip-vs-dpms-off-vs-modeset
[528.468883] Starting dynamic subtest: A-eDP1
[532.084775] Dynamic subtest A-eDP1: SUCCESS (3.617s)
[532.095169] Starting dynamic subtest: B-eDP1
[535.386480] Dynamic subtest B-eDP1: SUCCESS (3.297s)
[535.398106] Starting dynamic subtest: C-eDP1
[538.687450] Dynamic subtest C-eDP1: SUCCESS (3.301s)
[538.698231] Starting dynamic subtest: D-eDP1
[541.989614] Dynamic subtest D-eDP1: SUCCESS (3.301s)
[541.991920] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.526s)
[542.858464] [131/133] (514s left) gem_watchdog (default-virtual)
[542.930607] Starting subtest: default-virtual
[549.206336] Subtest default-virtual: SUCCESS (6.284s)
[549.305750] [132/133] (507s left) kms_pwrite_crc
[550.964357] [133/133] (506s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[551.069077] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[551.071312] Starting dynamic subtest: pipe-A-eDP-1
[557.885179] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.820s)
[557.901779] Starting dynamic subtest: pipe-B-eDP-1
[564.883100] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.994s)
[564.885372] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.817s)
[565.758913] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: gem_ctx_create
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_dsc
results: parsing output: 5/ for test: gem_eio
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: sriov_basic
results: parsing output: 8/ for test: syncobj_basic
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: gem_create
results: parsing output: 18/ for test: i915_suspend
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: gem_flink_basic
results: parsing output: 23/ for test: gem_lmem_swapping
results: parsing output: 24/ for test: kms_plane_scaling
results: parsing output: 25/ for test: vgem_basic
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: i915_pm_rps
results: parsing output: 30/ for test: gem_exec_whisper
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: vgem_basic
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gen9_exec_parse
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_caching
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_lmem_swapping
results: parsing output: 45/ for test: kms_plane_alpha_blend
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_sequence
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: i915_hangman
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: api_intel_allocator
results: parsing output: 55/ for test: gem_ctx_sseu
results: parsing output: 56/ for test: kms_force_connector_basic
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: kms_chamelium_hpd
results: parsing output: 59/ for test: kms_chamelium_frames
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gen7_exec_parse
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_scaling_modes
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_prop_blob
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: gem_softpin
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: syncobj_basic
results: parsing output: 79/ for test: kms_atomic
results: parsing output: 80/ for test: gen3_render_linear_blits
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: gem_linear_blits
results: parsing output: 85/ for test: kms_legacy_colorkey
results: parsing output: 86/ for test: gem_busy
results: parsing output: 87/ for test: prime_mmap
results: parsing output: 88/ for test: gem_readwrite
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_invalid_mode
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_exec_balancer
results: parsing output: 97/ for test: gem_softpin
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: syncobj_eventfd
results: parsing output: 100/ for test: dumb_buffer
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: gem_basic
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_chamelium_audio
results: parsing output: 106/ for test: kms_plane_multiple
results: parsing output: 107/ for test: kms_color_pipeline
results: parsing output: 108/ for test: kms_rotation_crc
results: parsing output: 109/ for test: sw_sync
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: gem_basic
results: parsing output: 114/ for test: gem_mmap_offset
results: parsing output: 115/ for test: syncobj_basic
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: gem_pread
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_pm_dc
results: parsing output: 123/ for test: kms_vblank
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: gem_pxp
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: gem_watchdog
results: parsing output: 131/ for test: kms_pwrite_crc
results: parsing output: 132/ for test: kms_psr2_sf
Done.