[59.587660] Initializing watchdogs
[59.587709]   /dev/watchdog0
[59.602001] [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]
[59.606258] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.608453] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.612133] [001/132] (960s left) kms_pm_backlight (brightness-with-dpms)
[59.720950] Starting subtest: brightness-with-dpms
[59.809863] Starting dynamic subtest: eDP-1
[62.204605] Dynamic subtest eDP-1: SUCCESS (2.385s)
[62.207045] Subtest brightness-with-dpms: SUCCESS (2.476s)
[63.070821] [002/132] (957s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[63.169716] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[63.173843] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[63.265448] [003/132] (956s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[63.366215] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[63.370491] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[63.460285] [004/132] (956s left) gem_ctx_exec (basic-norecovery)
[63.522420] Starting subtest: basic-norecovery
[63.707390] Subtest basic-norecovery: SUCCESS (0.184s)
[63.822908] [005/132] (956s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[63.936621] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[70.908801] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.966s)
[71.010555] [006/132] (949s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[71.063798] Starting subtest: wait-all-for-submit-delayed-submit
[71.168765] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[71.245656] [007/132] (949s left) kms_pipe_crc_basic (suspend-read-crc)
[71.339053] Starting subtest: suspend-read-crc
[71.341332] Starting dynamic subtest: pipe-A-eDP-1
[89.045427] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.554s)
[89.055096] Starting dynamic subtest: pipe-B-eDP-1
[107.039869] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.137s)
[107.048236] Starting dynamic subtest: pipe-C-eDP-1
[125.014406] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.014s)
[125.025274] Starting dynamic subtest: pipe-D-eDP-1
[142.999153] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.039s)
[143.002374] Subtest suspend-read-crc: SUCCESS (12.750s)
[143.849321] [008/132] (876s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[143.968110] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[143.973207] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[144.057276] [009/132] (876s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[144.154994] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[144.159947] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[144.248134] [010/132] (876s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[144.340199] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[144.345356] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[144.439827] [011/132] (876s left) core_getversion (all-cards)
[144.484571] Starting subtest: all-cards
[144.493131] Subtest all-cards: SUCCESS (0.011s)
[144.536112] [012/132] (875s left) i915_query (query-topology-coherent-slice-mask)
[144.583510] Starting subtest: query-topology-coherent-slice-mask
[144.588274] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[144.695456] [013/132] (875s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[144.787393] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[144.791586] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[144.855549] [014/132] (875s left) vgem_basic (dmabuf-fence-before)
[144.925287] Starting subtest: dmabuf-fence-before
[144.927824] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[144.980497] [FACT vgem_basic (dmabuf-fence-before)] new: kernel.kmod_is_loaded.vgem: true
[144.983531] [015/132] (875s left) gem_exec_balancer (hog)
[145.051433] Starting subtest: hog
[145.056181] Subtest hog: SKIP (0.000s)
[145.349332] [016/132] (875s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[145.446259] Starting subtest: fb-8bpc-vs-panel-6bpc
[145.449060] Starting dynamic subtest: pipe-A-eDP-1
[146.857372] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.402s)
[146.860293] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.403s)
[147.731049] [017/132] (872s left) gem_exec_schedule (preempt-queue-contexts-chain)
[147.806362] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[148.092669] [018/132] (872s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[148.194848] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[149.267242] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.068s)
[149.391379] [019/132] (871s left) i915_hangman (engine-error-state-capture)
[149.449506] Starting subtest: engine-error-state-capture
[149.452047] Starting dynamic subtest: rcs0
[153.072998] Dynamic subtest rcs0: SUCCESS (3.610s)
[153.086011] Starting dynamic subtest: bcs0
[159.089161] Dynamic subtest bcs0: SUCCESS (6.002s)
[159.101860] Starting dynamic subtest: vcs0
[165.040881] Dynamic subtest vcs0: SUCCESS (5.943s)
[165.052360] Starting dynamic subtest: vcs1
[169.072550] Dynamic subtest vcs1: SUCCESS (4.026s)
[169.084125] Starting dynamic subtest: vecs0
[174.127865] Dynamic subtest vecs0: SUCCESS (5.052s)
[174.139325] Starting dynamic subtest: ccs0
[180.080517] Dynamic subtest ccs0: SUCCESS (5.952s)
[180.083500] Subtest engine-error-state-capture: SUCCESS (30.595s)
[180.162663] [020/132] (840s left) gem_exec_endless (dispatch)
[180.248973] Starting subtest: dispatch
[180.251505] Starting dynamic subtest: rcs0
[180.257643] Dynamic subtest rcs0: SUCCESS (0.005s)
[180.267969] Starting dynamic subtest: bcs0
[180.273148] Dynamic subtest bcs0: SUCCESS (0.004s)
[180.282352] Starting dynamic subtest: vcs0
[180.287157] Dynamic subtest vcs0: SUCCESS (0.004s)
[180.295475] Starting dynamic subtest: vcs1
[180.300328] Dynamic subtest vcs1: SUCCESS (0.005s)
[180.308500] Starting dynamic subtest: vecs0
[180.313340] Dynamic subtest vecs0: SUCCESS (0.007s)
[180.321638] Starting dynamic subtest: ccs0
[180.326590] Dynamic subtest ccs0: SUCCESS (0.004s)
[180.328944] Subtest dispatch: SUCCESS (0.033s)
[182.205912] [021/132] (838s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[182.302067] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[182.304798] Starting dynamic subtest: pipe-A-eDP-1
[182.451297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[182.460773] Starting dynamic subtest: pipe-B-eDP-1
[182.483414] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[182.492886] Starting dynamic subtest: pipe-C-eDP-1
[182.513968] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[182.522565] Starting dynamic subtest: pipe-D-eDP-1
[182.544592] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[182.546750] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.176s)
[184.752158] [022/132] (836s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[184.849340] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[184.854168] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[184.931559] [023/132] (836s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[185.052337] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[185.057065] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[185.211404] [024/132] (835s left) kms_vblank (ts-continuation-modeset-hang)
[185.298365] Starting subtest: ts-continuation-modeset-hang
[185.301142] Starting dynamic subtest: pipe-A-eDP-1
[211.855029] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.548s)
[211.872240] Starting dynamic subtest: pipe-D-eDP-1
[236.892991] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.030s)
[236.896158] Subtest ts-continuation-modeset-hang: SUCCESS (51.582s)
[237.763800] [025/132] (783s left) gen9_exec_parse (bb-oversize)
[237.838257] Subtest bb-oversize: SKIP (0.000s)
[237.917026] [026/132] (783s left) kms_frontbuffer_tracking (psr-suspend)
[238.012326] Starting subtest: psr-suspend
[276.685026] Subtest psr-suspend: SUCCESS (7.861s)
[276.801453] [027/132] (744s left) kms_atomic (plane-invalid-params-fence)
[276.899947] Starting subtest: plane-invalid-params-fence
[276.902365] Starting dynamic subtest: pipe-A-eDP-1
[277.255707] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.353s)
[277.258621] Subtest plane-invalid-params-fence: SUCCESS (0.355s)
[278.123145] [028/132] (743s left) kms_psr (fbc-pr-sprite-blt)
[278.218538] Starting subtest: fbc-pr-sprite-blt
[278.224186] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[278.298057] [029/132] (742s left) gem_mmap_gtt (medium-copy-odd)
[278.358519] Subtest medium-copy-odd: SKIP (0.000s)
[278.417178] [030/132] (742s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[278.504209] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[278.506745] Starting dynamic subtest: pipe-A-default-mode
[279.696642] Dynamic subtest pipe-A-default-mode: SKIP (1.178s)
[279.701660] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.179s)
[279.844089] [031/132] (741s left) kms_addfb_basic (invalid-set-prop)
[279.891876] Starting subtest: invalid-set-prop
[279.894037] Subtest invalid-set-prop: SUCCESS (0.000s)
[280.020644] [032/132] (741s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[280.071153] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[280.176055] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[280.255817] [033/132] (741s left) syncobj_wait (invalid-reset-zero-handles)
[280.313740] Starting subtest: invalid-reset-zero-handles
[280.316635] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[280.404631] [034/132] (741s left) gem_bad_reloc (negative-reloc-lut)
[280.474581] Subtest negative-reloc-lut: SKIP (0.000s)
[280.545480] [035/132] (740s left) kms_plane_multiple (2x-tiling-yf)
[280.644637] Starting subtest: 2x-tiling-yf
[280.649485] Subtest 2x-tiling-yf: SKIP (0.000s)
[280.716738] [036/132] (740s left) api_intel_bb (simple-bb)
[280.771445] Starting subtest: simple-bb
[280.776535] Subtest simple-bb: SUCCESS (0.006s)
[280.885616] [037/132] (740s left) api_intel_bb (bb-with-allocator)
[280.948413] Starting subtest: bb-with-allocator
[280.953750] Subtest bb-with-allocator: SUCCESS (0.006s)
[281.072052] [038/132] (740s left) kms_flip (flip-vs-fences-interruptible)
[281.171736] Starting subtest: flip-vs-fences-interruptible
[281.176734] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[281.265793] [039/132] (740s left) syncobj_timeline (invalid-transfer-bad-pad)
[281.321214] Starting subtest: invalid-transfer-bad-pad
[281.323733] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[281.437258] [040/132] (740s left) gem_workarounds (suspend-resume-fd)
[281.494863] Starting subtest: suspend-resume-fd
[297.137763] Subtest suspend-resume-fd: SUCCESS (1.210s)
[297.275841] [041/132] (724s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[297.379201] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[297.381948] Starting dynamic subtest: pipe-A
[297.441612] Dynamic subtest pipe-A: SUCCESS (0.065s)
[297.455168] Starting dynamic subtest: pipe-B
[298.632147] Dynamic subtest pipe-B: SUCCESS (1.179s)
[298.643220] Starting dynamic subtest: pipe-C
[299.757875] Dynamic subtest pipe-C: SUCCESS (1.115s)
[299.767328] Starting dynamic subtest: pipe-D
[300.890846] Dynamic subtest pipe-D: SUCCESS (1.125s)
[300.893260] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.486s)
[302.064351] [042/132] (719s left) i915_drm_fdinfo (most-busy-idle-check-all)
[302.109254] Starting subtest: most-busy-idle-check-all
[302.112183] Starting dynamic subtest: rcs0
[302.117084] Dynamic subtest rcs0: SKIP (0.003s)
[302.128371] Starting dynamic subtest: bcs0
[302.133359] Dynamic subtest bcs0: SKIP (0.000s)
[302.142337] Starting dynamic subtest: vcs0
[302.147215] Dynamic subtest vcs0: SKIP (0.000s)
[302.155913] Starting dynamic subtest: vcs1
[302.160613] Dynamic subtest vcs1: SKIP (0.000s)
[302.170315] Starting dynamic subtest: vecs0
[302.175145] Dynamic subtest vecs0: SKIP (0.000s)
[302.184231] Starting dynamic subtest: ccs0
[302.189179] Dynamic subtest ccs0: SKIP (0.000s)
[302.194067] Subtest most-busy-idle-check-all: SKIP (0.008s)
[302.234877] [043/132] (719s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[302.355505] Starting subtest: invalid-modeset-force-ultra-joiner
[302.359913] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[302.420480] [044/132] (719s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[302.480947] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[302.541191] [045/132] (719s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[302.637045] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[309.427043] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.769s)
[309.596400] [046/132] (712s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[309.658597] Starting subtest: legacy-engines-hostile-preempt
[309.661261] Starting dynamic subtest: render
[309.721993] Dynamic subtest render: SUCCESS (0.063s)
[309.732724] Starting dynamic subtest: bsd1
[311.362573] Dynamic subtest bsd1: SUCCESS (1.634s)
[311.373705] Starting dynamic subtest: bsd2
[313.334161] Dynamic subtest bsd2: SUCCESS (1.965s)
[313.345327] Starting dynamic subtest: blt
[313.382029] Dynamic subtest blt: SUCCESS (0.046s)
[313.391527] Starting dynamic subtest: vebox
[315.383850] Dynamic subtest vebox: SUCCESS (1.996s)
[315.386949] Subtest legacy-engines-hostile-preempt: SUCCESS (5.715s)
[315.467428] [047/132] (706s left) kms_chamelium_hpd (hdmi-hpd-storm)
[315.870111] Subtest hdmi-hpd-storm: SKIP (0.000s)
[316.644875] [048/132] (705s left) perf (invalid-oa-metric-set-id)
[316.805518] Starting subtest: invalid-oa-metric-set-id
[316.815095] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[316.854653] [049/132] (705s left) gem_fenced_exec_thrash (no-spare-fences)
[316.907974] Subtest no-spare-fences: SKIP (0.000s)
[316.978710] [050/132] (705s left) kms_atomic_transition (plane-all-modeset-transition)
[317.076363] Starting subtest: plane-all-modeset-transition
[317.081968] Subtest plane-all-modeset-transition: SKIP (0.000s)
[317.149129] [051/132] (705s left) gem_ringfill (legacy-basic)
[322.368324] Starting subtest: legacy-basic
[322.371412] Starting dynamic subtest: default
[322.425624] Dynamic subtest default: SUCCESS (0.057s)
[322.441611] Starting dynamic subtest: render
[322.471241] Dynamic subtest render: SUCCESS (0.042s)
[322.483937] Starting dynamic subtest: bsd
[322.515828] Dynamic subtest bsd: SUCCESS (0.042s)
[322.526646] Starting dynamic subtest: bsd1
[322.556356] Dynamic subtest bsd1: SUCCESS (0.038s)
[322.567331] Starting dynamic subtest: bsd2
[322.599328] Dynamic subtest bsd2: SUCCESS (0.041s)
[322.609603] Starting dynamic subtest: blt
[322.646641] Dynamic subtest blt: SUCCESS (0.044s)
[322.658361] Starting dynamic subtest: vebox
[322.689672] Dynamic subtest vebox: SUCCESS (0.040s)
[322.692492] Subtest legacy-basic: SUCCESS (0.324s)
[322.767794] [052/132] (699s left) gem_exec_params (invalid-ring)
[322.827900] Starting subtest: invalid-ring
[322.830597] Subtest invalid-ring: SUCCESS (0.000s)
[322.929514] [053/132] (699s left) prime_mmap (test_dup)
[322.981724] Starting subtest: test_dup
[322.984059] Starting dynamic subtest: test_dup-smem
[323.009936] Dynamic subtest test_dup-smem: SUCCESS (0.031s)
[323.012814] Subtest test_dup: SUCCESS (0.032s)
[323.088682] [054/132] (699s left) kms_dsc (dsc-basic)
[323.193003] Starting subtest: dsc-basic
[323.210195] Subtest dsc-basic: SKIP (0.000s)
[323.313437] [055/132] (699s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[323.412987] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[323.414986] Starting dynamic subtest: pipe-A-eDP-1
[325.424555] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.011s)
[325.433776] Starting dynamic subtest: pipe-B-eDP-1
[327.722117] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.294s)
[327.731534] Starting dynamic subtest: pipe-C-eDP-1
[329.735942] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.014s)
[329.744988] Starting dynamic subtest: pipe-D-eDP-1
[331.800612] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.064s)
[331.803623] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.388s)
[333.021446] [056/132] (689s left) gem_exec_fence (basic-wait-all)
[333.088261] Starting subtest: basic-wait-all
[333.164700] Subtest basic-wait-all: SUCCESS (0.078s)
[335.431953] [057/132] (687s left) kms_psr (fbc-psr-sprite-render)
[335.536099] Starting subtest: fbc-psr-sprite-render
[335.538861] Starting dynamic subtest: eDP-1
[335.544118] Dynamic subtest eDP-1: SKIP (0.000s)
[335.549108] Subtest fbc-psr-sprite-render: SKIP (0.003s)
[335.621269] [058/132] (686s left) gem_mmap_gtt (big-copy-xy)
[335.695129] Subtest big-copy-XY: SKIP (0.000s)
[335.759772] [059/132] (686s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[335.853270] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[342.526114] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.674s)
[342.627416] [060/132] (680s left) kms_properties (get_properties-sanity-atomic)
[342.714914] Starting subtest: get_properties-sanity-atomic
[342.717817] Subtest get_properties-sanity-atomic: SUCCESS (0.003s)
[342.798744] [061/132] (679s left) gem_softpin (allocator-evict)
[342.868817] Starting subtest: allocator-evict
[342.871354] Starting dynamic subtest: rcs0
[366.410150] Dynamic subtest rcs0: SUCCESS (23.537s)
[366.423499] Starting dynamic subtest: bcs0
[390.220910] Dynamic subtest bcs0: SUCCESS (23.800s)
[390.236381] Starting dynamic subtest: vcs0
[415.355826] Dynamic subtest vcs0: SUCCESS (25.137s)
[415.369331] Starting dynamic subtest: vcs1
[438.989686] Dynamic subtest vcs1: SUCCESS (23.630s)
[439.002240] Starting dynamic subtest: vecs0
[462.537472] Dynamic subtest vecs0: SUCCESS (23.540s)
[462.549887] Starting dynamic subtest: ccs0
[486.001876] Dynamic subtest ccs0: SUCCESS (23.454s)
[486.005168] Subtest allocator-evict: SUCCESS (143.110s)
[486.084919] [062/132] (536s left) kms_pm_rpm (i2c)
[487.703367] Starting subtest: i2c
[493.457045] Subtest i2c: SUCCESS (5.756s)
[493.582116] [063/132] (529s left) kms_sequence (get-busy)
[493.670363] Starting subtest: get-busy
[493.673156] Starting dynamic subtest: pipe-A-eDP-1
[495.592341] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.921s)
[495.604064] Starting dynamic subtest: pipe-B-eDP-1
[498.231938] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.636s)
[498.243260] Starting dynamic subtest: pipe-C-eDP-1
[500.822110] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.590s)
[500.833412] Starting dynamic subtest: pipe-D-eDP-1
[503.371248] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s)
[503.374101] Subtest get-busy: SUCCESS (9.696s)
[504.250615] [064/132] (518s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[504.827958] Starting subtest: syncobj-timeline-multiple-ext-nodes
[504.833100] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[506.381940] [065/132] (516s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[506.483749] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[513.226899] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.743s)
[513.416925] [066/132] (509s left) kms_psr (fbc-psr-primary-mmap-gtt)
[513.511254] Starting subtest: fbc-psr-primary-mmap-gtt
[513.514037] Starting dynamic subtest: eDP-1
[513.519058] Dynamic subtest eDP-1: SKIP (0.000s)
[513.524067] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[513.586727] [067/132] (509s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[513.687024] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[513.689617] Starting dynamic subtest: pipe-A-eDP-1
[513.758884] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[513.771171] Starting dynamic subtest: pipe-B-eDP-1
[513.837738] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[513.847998] Starting dynamic subtest: pipe-C-eDP-1
[513.914951] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[513.925193] Starting dynamic subtest: pipe-D-eDP-1
[513.992259] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[513.997871] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[515.983230] [068/132] (507s left) kms_cursor_edge_walk (256x256-left-edge)
[516.077318] Starting subtest: 256x256-left-edge
[516.080304] Starting dynamic subtest: pipe-A-eDP-1
[519.532166] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[519.543043] Starting dynamic subtest: pipe-D-eDP-1
[522.670067] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.136s)
[522.672177] Subtest 256x256-left-edge: SUCCESS (6.592s)
[523.473833] [069/132] (499s left) kms_psr (psr-cursor-mmap-cpu)
[523.568013] Starting subtest: psr-cursor-mmap-cpu
[523.570350] Starting dynamic subtest: eDP-1
[525.294006] Dynamic subtest eDP-1: SUCCESS (1.725s)
[525.296793] Subtest psr-cursor-mmap-cpu: SUCCESS (1.725s)
[526.148494] [070/132] (496s left) gen7_exec_parse (basic-allowed)
[526.215147] Subtest basic-allowed: SKIP (0.000s)
[526.299405] [071/132] (496s left) i915_query (query-regions-sanity-check)
[526.354170] Starting subtest: query-regions-sanity-check
[526.364237] Subtest query-regions-sanity-check: SUCCESS (0.013s)
[526.475904] [072/132] (496s left) i915_pm_rpm (system-suspend-devices)
[528.498218] Starting subtest: system-suspend-devices
[536.164255] Subtest system-suspend-devices: SUCCESS (7.671s)
[536.550699] [073/132] (486s left) prime_vgem (shrink)
[536.628065] Starting subtest: shrink
[536.648367] Subtest shrink: SUCCESS (0.017s)
[536.733680] [074/132] (486s left) gem_exec_whisper (basic-forked-all)
[536.804014] Starting subtest: basic-forked-all
[550.334480] Subtest basic-forked-all: SUCCESS (13.530s)
[550.524255] [075/132] (472s left) sysfs_preempt_timeout (invalid)
[550.581470] Starting subtest: invalid
[550.584065] Starting dynamic subtest: vecs0
[550.586809] Dynamic subtest vecs0: SUCCESS (0.000s)
[550.597200] Starting dynamic subtest: ccs0
[550.600257] Dynamic subtest ccs0: SUCCESS (0.000s)
[550.610450] Starting dynamic subtest: vcs0
[550.613244] Dynamic subtest vcs0: SUCCESS (0.000s)
[550.623305] Starting dynamic subtest: bcs0
[550.625723] Dynamic subtest bcs0: SUCCESS (0.000s)
[550.635937] Starting dynamic subtest: rcs0
[550.638371] Dynamic subtest rcs0: SUCCESS (0.000s)
[550.648863] Starting dynamic subtest: vcs1
[550.651038] Dynamic subtest vcs1: SUCCESS (0.000s)
[550.653569] Subtest invalid: SUCCESS (0.005s)
[550.694627] [076/132] (472s left) kms_addfb_basic (unused-offsets)
[550.746160] Starting subtest: unused-offsets
[550.748884] Subtest unused-offsets: SUCCESS (0.000s)
[550.888849] [077/132] (472s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[550.981228] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[550.986909] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[551.058346] [078/132] (472s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[551.112334] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[551.117058] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[551.295933] [079/132] (472s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[551.437053] Starting subtest: dp-mst-lic-type-0-hdcp14
[551.442090] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[551.569081] [080/132] (472s left) kms_hdr (invalid-hdr)
[551.665790] Starting subtest: invalid-hdr
[553.719261] Starting dynamic subtest: pipe-A-eDP-1
[556.672880] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.954s)
[556.675652] Subtest invalid-hdr: SUCCESS (5.010s)
[556.782477] [081/132] (466s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[556.876128] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[556.881143] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[556.975048] [082/132] (466s left) gem_mmap_wc (coherency)
[557.040113] Subtest coherency: SKIP (0.000s)
[557.099794] [083/132] (466s left) kms_flip (2x-flip-vs-panning-interruptible)
[557.196416] Starting subtest: 2x-flip-vs-panning-interruptible
[557.208317] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[557.291090] [084/132] (466s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[557.388355] Starting subtest: psr-1p-pri-indfb-multidraw
[579.594126] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.210s)
[579.707716] [085/132] (444s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[579.815312] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[579.817892] Starting dynamic subtest: pipe-A-eDP-1
[579.842569] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[579.855971] Starting dynamic subtest: pipe-B-eDP-1
[579.879872] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[579.890387] Starting dynamic subtest: pipe-C-eDP-1
[579.915216] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[579.927038] Starting dynamic subtest: pipe-D-eDP-1
[579.952067] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[579.956335] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[582.036697] [086/132] (441s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[582.134591] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[582.137252] Starting dynamic subtest: A-eDP1
[585.760536] Dynamic subtest A-eDP1: SUCCESS (3.623s)
[585.773059] Starting dynamic subtest: B-eDP1
[588.952360] Dynamic subtest B-eDP1: SUCCESS (3.189s)
[588.964186] Starting dynamic subtest: C-eDP1
[592.043549] Dynamic subtest C-eDP1: SUCCESS (3.091s)
[592.055930] Starting dynamic subtest: D-eDP1
[595.155038] Dynamic subtest D-eDP1: SUCCESS (3.110s)
[595.157895] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.020s)
[595.958009] [087/132] (427s left) kms_flip (2x-nonexisting-fb-interruptible)
[596.057745] Starting subtest: 2x-nonexisting-fb-interruptible
[596.069351] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[596.149126] [088/132] (427s left) gem_create (create-massive)
[596.206140] Starting subtest: create-massive
[596.209140] Subtest create-massive: SUCCESS (0.000s)
[596.393979] [089/132] (427s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[596.493180] Starting subtest: 2x-absolute-wf_vblank-interruptible
[596.507126] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.012s)
[596.583214] [090/132] (427s left) gem_exec_whisper (basic-queues-forked)
[596.648666] Starting subtest: basic-queues-forked
[619.541208] Subtest basic-queues-forked: SUCCESS (22.888s)
[619.741109] [091/132] (404s left) gem_mmap_gtt (coherency)
[619.801134] Subtest coherency: SKIP (0.000s)
[619.867134] [092/132] (404s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[619.959990] Starting subtest: plane-downscale-factor-0-5-with-rotation
[619.962600] Starting dynamic subtest: pipe-A
[619.979995] Dynamic subtest pipe-A: SKIP (0.015s)
[619.991169] Starting dynamic subtest: pipe-B
[620.006488] Dynamic subtest pipe-B: SKIP (0.028s)
[620.016769] Starting dynamic subtest: pipe-C
[620.034266] Dynamic subtest pipe-C: SKIP (0.027s)
[620.044830] Starting dynamic subtest: pipe-D
[620.062019] Dynamic subtest pipe-D: SKIP (0.027s)
[620.067025] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.099s)
[620.158419] [093/132] (403s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[620.260240] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[620.265314] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[620.367047] [094/132] (403s left) syncobj_wait (wait-for-submit-complex)
[620.427367] Starting subtest: wait-for-submit-complex
[620.489314] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[620.566753] [095/132] (403s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[620.657332] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[620.659225] Starting dynamic subtest: pipe-A-eDP-1
[631.364812] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.708s)
[631.375476] Starting dynamic subtest: pipe-B-eDP-1
[642.783124] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.415s)
[642.786222] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.126s)
[643.642059] [096/132] (380s left) kms_lease (empty-lease)
[643.729978] Starting subtest: empty-lease
[643.732472] Starting dynamic subtest: pipe-A-eDP-1
[643.734876] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[643.745356] Starting dynamic subtest: pipe-B-eDP-1
[643.748076] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[643.758684] Starting dynamic subtest: pipe-C-eDP-1
[643.761609] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[643.772367] Starting dynamic subtest: pipe-D-eDP-1
[643.775121] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[643.777914] Subtest empty-lease: SUCCESS (0.008s)
[643.843947] [097/132] (380s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[643.941377] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[643.946339] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[644.037302] [098/132] (380s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[644.425109] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[645.242559] [099/132] (379s left) kms_flip (2x-plain-flip)
[645.343916] Starting subtest: 2x-plain-flip
[645.361813] Subtest 2x-plain-flip: SKIP (0.018s)
[645.449583] [100/132] (378s left) kms_cursor_crc (cursor-offscreen-256x85)
[645.695432] Starting subtest: cursor-offscreen-256x85
[645.744833] Subtest cursor-offscreen-256x85: SKIP (0.042s)
[645.921734] [101/132] (378s left) kms_atomic_interruptible (legacy-dpms)
[646.008352] Starting subtest: legacy-dpms
[646.011074] Starting dynamic subtest: pipe-A-eDP-1
[653.383293] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.373s)
[653.386184] Subtest legacy-dpms: SUCCESS (7.375s)
[654.223030] [102/132] (370s left) gem_mmap_offset (pf-nonblock)
[654.293919] Starting subtest: pf-nonblock
[654.300018] Subtest pf-nonblock: SUCCESS (0.008s)
[654.421025] [103/132] (370s left) gem_mmap_wc (write-cpu-read-wc)
[654.474622] Subtest write-cpu-read-wc: SKIP (0.000s)
[654.535498] [104/132] (370s left) gem_flink_basic (flink-lifetime)
[654.597736] Starting subtest: flink-lifetime
[654.600343] Subtest flink-lifetime: SUCCESS (0.002s)
[654.712777] [105/132] (369s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[654.816929] Starting subtest: 4-tiled-32bpp-rotate-90
[654.838144] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[654.941942] [106/132] (369s left) kms_addfb_basic (tile-pitch-mismatch)
[654.989639] Starting subtest: tile-pitch-mismatch
[654.994356] Subtest tile-pitch-mismatch: SKIP (0.000s)
[655.112481] [107/132] (369s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[655.218252] Starting subtest: plane-lut1d-pre-ctm3x4
[655.351860] Starting dynamic subtest: pipe-A-plane-0
[655.507202] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[655.518811] Starting dynamic subtest: pipe-A-plane-1
[655.640710] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[655.651551] Starting dynamic subtest: pipe-A-plane-2
[655.785104] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[657.013365] Starting dynamic subtest: pipe-B-plane-0
[657.157191] Dynamic subtest pipe-B-plane-0: SUCCESS (0.154s)
[657.172053] Starting dynamic subtest: pipe-B-plane-1
[657.344315] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[657.355333] Starting dynamic subtest: pipe-B-plane-2
[657.488968] Dynamic subtest pipe-B-plane-2: SUCCESS (0.143s)
[658.648926] Starting dynamic subtest: pipe-C-plane-0
[658.783933] Dynamic subtest pipe-C-plane-0: SUCCESS (0.143s)
[658.794941] Starting dynamic subtest: pipe-C-plane-1
[658.938594] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[658.949942] Starting dynamic subtest: pipe-C-plane-2
[659.083148] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[660.292737] Starting dynamic subtest: pipe-D-plane-0
[660.418605] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[660.432574] Starting dynamic subtest: pipe-D-plane-1
[660.564753] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[660.576340] Starting dynamic subtest: pipe-D-plane-2
[660.718978] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[661.003342] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.787s)
[661.859799] [108/132] (362s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[661.958162] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[661.963307] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[662.058350] [109/132] (362s left) perf_pmu (init-wait)
[662.102992] Starting subtest: init-wait
[662.105998] Starting dynamic subtest: rcs0
[662.108834] Dynamic subtest rcs0: SUCCESS (0.002s)
[662.122344] Starting dynamic subtest: bcs0
[662.124545] Dynamic subtest bcs0: SUCCESS (0.001s)
[662.134253] Starting dynamic subtest: vcs0
[662.136354] Dynamic subtest vcs0: SUCCESS (0.001s)
[662.146087] Starting dynamic subtest: vcs1
[662.148358] Dynamic subtest vcs1: SUCCESS (0.001s)
[662.157741] Starting dynamic subtest: vecs0
[662.159735] Dynamic subtest vecs0: SUCCESS (0.001s)
[662.169585] Starting dynamic subtest: ccs0
[662.171829] Dynamic subtest ccs0: SUCCESS (0.000s)
[662.174063] Subtest init-wait: SUCCESS (0.008s)
[662.232568] [110/132] (362s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[662.331003] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[662.335245] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[662.438147] [111/132] (362s left) kms_psr (psr-sprite-mmap-cpu)
[662.533639] Starting subtest: psr-sprite-mmap-cpu
[662.535857] Starting dynamic subtest: eDP-1
[664.277194] Dynamic subtest eDP-1: SUCCESS (1.743s)
[664.280153] Subtest psr-sprite-mmap-cpu: SUCCESS (1.744s)
[665.119377] [112/132] (359s left) perf (gen12-group-exclusive-stream-sample-oa)
[665.231068] Starting subtest: gen12-group-exclusive-stream-sample-oa
[665.252595] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s)
[665.306441] [113/132] (359s left) kms_flip (2x-flip-vs-dpms-on-nop)
[665.403100] Starting subtest: 2x-flip-vs-dpms-on-nop
[665.412212] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[665.490955] [114/132] (359s left) gem_exec_schedule (lateslice)
[665.557045] Starting subtest: lateslice
[665.559130] Starting dynamic subtest: rcs0
[665.573657] Dynamic subtest rcs0: SUCCESS (0.026s)
[665.585492] Starting dynamic subtest: bcs0
[665.592093] Dynamic subtest bcs0: SUCCESS (0.018s)
[665.602351] Starting dynamic subtest: vcs0
[665.610031] Dynamic subtest vcs0: SUCCESS (0.017s)
[665.620050] Starting dynamic subtest: vcs1
[665.628748] Dynamic subtest vcs1: SUCCESS (0.018s)
[665.638932] Starting dynamic subtest: vecs0
[665.648726] Dynamic subtest vecs0: SUCCESS (0.019s)
[665.658869] Starting dynamic subtest: ccs0
[665.667320] Dynamic subtest ccs0: SUCCESS (0.018s)
[665.670118] Subtest lateslice: SUCCESS (0.121s)
[667.399183] [115/132] (357s left) gem_exec_reloc (basic-concurrent0)
[667.463987] Subtest basic-concurrent0: SKIP (0.000s)
[667.525125] [116/132] (357s left) kms_async_flips (async-flip-dpms)
[667.618805] Starting subtest: async-flip-dpms
[667.994358] Starting dynamic subtest: pipe-A-eDP-1
[671.843291] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.847s)
[672.215144] Starting dynamic subtest: pipe-B-eDP-1
[674.999761] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.790s)
[675.380311] Starting dynamic subtest: pipe-C-eDP-1
[678.164138] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.793s)
[678.542205] Starting dynamic subtest: pipe-D-eDP-1
[681.336269] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.801s)
[681.339151] Subtest async-flip-dpms: SUCCESS (13.715s)
[682.519091] [117/132] (342s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[682.618880] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[682.623550] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[682.751260] [118/132] (342s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[682.827897] Starting subtest: invalid-bsd2-flag-on-vebox
[682.830646] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[682.946941] [119/132] (342s left) gem_mmap_offset (partial-mmap)
[682.999049] Starting subtest: partial-mmap
[683.000956] Starting dynamic subtest: smem0
[683.003557] Dynamic subtest smem0: SUCCESS (0.004s)
[683.006004] Subtest partial-mmap: SUCCESS (0.005s)
[683.126996] [120/132] (342s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[683.188961] Starting subtest: multi-wait-all-for-submit-signaled
[683.191623] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[683.299848] [121/132] (342s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[683.393581] Starting subtest: y-tiled-16bpp-rotate-180
[683.398973] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[683.492970] [122/132] (341s left) kms_cursor_crc (cursor-random-512x170)
[683.789115] Starting subtest: cursor-random-512x170
[683.793983] Subtest cursor-random-512x170: SKIP (0.002s)
[683.933853] [123/132] (341s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[684.028980] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[684.031175] Starting dynamic subtest: pipe-A-eDP-1
[690.603884] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.577s)
[690.617306] Starting dynamic subtest: pipe-B-eDP-1
[697.519040] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.914s)
[697.521238] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.493s)
[698.399247] [124/132] (327s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[698.465233] Starting subtest: invalid-multi-wait-all-unsubmitted
[698.467790] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[698.563553] [125/132] (327s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[698.655992] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[698.661078] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[699.834625] [126/132] (325s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[699.933785] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[699.939142] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[700.034221] [127/132] (325s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[700.145614] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[700.769230] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[700.931662] [128/132] (324s left) gem_tiled_wb
[701.056027] [129/132] (324s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[701.155796] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[701.161031] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[701.227536] [130/132] (324s left) gen3_mixed_blits
[701.350051] [131/132] (324s left) gem_eio (in-flight-10ms)
[701.567950] Starting subtest: in-flight-10ms
[710.139171] Subtest in-flight-10ms: SUCCESS (8.569s)
[710.273762] [132/132] (315s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[710.384468] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[717.302492] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.921s)
[717.415414] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_backlight
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_ctx_exec
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_pipe_crc_basic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: core_getversion
results: parsing output: 11/ for test: i915_query
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: vgem_basic
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_dither
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: i915_hangman
results: parsing output: 19/ for test: gem_exec_endless
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_vblank
results: parsing output: 24/ for test: gen9_exec_parse
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_atomic
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: kms_flip_scaled_crc
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: gem_bad_reloc
results: parsing output: 34/ for test: kms_plane_multiple
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: api_intel_bb
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_workarounds
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: i915_drm_fdinfo
results: parsing output: 42/ for test: kms_joiner
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_ctx_persistence
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: gem_fenced_exec_thrash
results: parsing output: 49/ for test: kms_atomic_transition
results: parsing output: 50/ for test: gem_ringfill
results: parsing output: 51/ for test: gem_exec_params
results: parsing output: 52/ for test: prime_mmap
results: parsing output: 53/ for test: kms_dsc
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_properties
results: parsing output: 60/ for test: gem_softpin
results: parsing output: 61/ for test: kms_pm_rpm
results: parsing output: 62/ for test: kms_sequence
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_cursor_edge_walk
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gen7_exec_parse
results: parsing output: 70/ for test: i915_query
results: parsing output: 71/ for test: i915_pm_rpm
results: parsing output: 72/ for test: prime_vgem
results: parsing output: 73/ for test: gem_exec_whisper
results: parsing output: 74/ for test: sysfs_preempt_timeout
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_content_protection
results: parsing output: 79/ for test: kms_hdr
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: gem_create
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_exec_whisper
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: kms_lease
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_chamelium_frames
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_atomic_interruptible
results: parsing output: 101/ for test: gem_mmap_offset
results: parsing output: 102/ for test: gem_mmap_wc
results: parsing output: 103/ for test: gem_flink_basic
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: kms_color_pipeline
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_async_flips
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_exec_params
results: parsing output: 118/ for test: gem_mmap_offset
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_tiled_wb
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: gen3_mixed_blits
results: parsing output: 130/ for test: gem_eio
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.