[54.971159] Initializing watchdogs
[54.971206]   /dev/watchdog0
[54.984536] [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]
[54.988756] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.990909] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.994206] [001/131] (960s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[60.109494] Starting subtest: pr-cursor-plane-update-sf
[60.114106] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[60.940815] [002/131] (954s left) syncobj_wait (multi-wait-for-submit-submitted)
[61.007043] Starting subtest: multi-wait-for-submit-submitted
[61.111288] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s)
[61.180977] [003/131] (954s left) kms_cursor_crc (cursor-random-512x512)
[61.441867] Starting subtest: cursor-random-512x512
[61.446278] Subtest cursor-random-512x512: SKIP (0.001s)
[61.597197] [004/131] (954s left) drm_read (short-buffer-wakeup)
[61.786879] Starting subtest: short-buffer-wakeup
[94.036159] Subtest short-buffer-wakeup: SUCCESS (32.217s)
[94.185841] [005/131] (921s left) kms_sequence (get-forked)
[94.284840] Starting subtest: get-forked
[94.287079] Starting dynamic subtest: pipe-A-eDP-1
[96.156225] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.867s)
[96.163517] Starting dynamic subtest: pipe-B-eDP-1
[98.698985] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.542s)
[98.707511] Starting dynamic subtest: pipe-C-eDP-1
[101.203745] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.503s)
[101.212339] Starting dynamic subtest: pipe-D-eDP-1
[103.719434] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.514s)
[103.721735] Subtest get-forked: SUCCESS (9.430s)
[104.562652] [006/131] (911s left) gem_softpin (zero)
[104.636094] Starting subtest: zero
[104.642062] Subtest zero: SUCCESS (0.005s)
[104.756877] [007/131] (910s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[104.875816] Starting subtest: short-busy-flip-before-cursor-toggle
[104.880085] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[105.004657] [008/131] (910s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[105.100092] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[105.102469] Starting dynamic subtest: pipe-A
[106.655578] Dynamic subtest pipe-A: SUCCESS (1.556s)
[106.663586] Starting dynamic subtest: pipe-B
[109.254749] Dynamic subtest pipe-B: SUCCESS (2.599s)
[109.262965] Starting dynamic subtest: pipe-C
[110.489365] Dynamic subtest pipe-C: SUCCESS (1.234s)
[110.498223] Starting dynamic subtest: pipe-D
[111.686804] Dynamic subtest pipe-D: SUCCESS (1.197s)
[111.689260] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (6.586s)
[112.870725] [009/131] (902s left) gem_userptr_blits (create-destroy-unsync)
[112.940991] Subtest create-destroy-unsync: SKIP (0.000s)
[113.077692] [010/131] (902s left) gem_userptr_blits (sync-unmap-cycles)
[113.142791] Starting subtest: sync-unmap-cycles
[118.523773] Subtest sync-unmap-cycles: SUCCESS (5.382s)
[118.661061] [011/131] (897s left) kms_big_fb (linear-8bpp-rotate-90)
[118.775269] Starting subtest: linear-8bpp-rotate-90
[118.795452] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[118.917751] [012/131] (896s left) kms_psr (fbc-psr-primary-mmap-gtt)
[119.008814] Starting subtest: fbc-psr-primary-mmap-gtt
[119.010853] Starting dynamic subtest: eDP-1
[119.014307] Dynamic subtest eDP-1: SKIP (0.000s)
[119.017739] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[119.076274] [013/131] (896s left) syncobj_wait (signal)
[119.125463] Starting subtest: signal
[119.127246] Subtest signal: SUCCESS (0.000s)
[119.209355] [014/131] (896s left) syncobj_wait (wait-any-snapshot)
[119.269485] Starting subtest: wait-any-snapshot
[119.348823] Subtest wait-any-snapshot: SUCCESS (0.081s)
[119.418146] [015/131] (896s left) syncobj_wait (wait-any-complex)
[119.476327] Starting subtest: wait-any-complex
[119.536929] Subtest wait-any-complex: SUCCESS (0.061s)
[119.605994] [016/131] (896s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[119.701519] Starting subtest: fbcpsr-slowdraw
[144.789859] Subtest fbcpsr-slowdraw: SUCCESS (25.089s)
[144.942958] [017/131] (871s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[145.046135] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[145.050414] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[145.154142] [018/131] (870s left) gem_ctx_shared (exec-single-timeline)
[145.207602] Starting subtest: exec-single-timeline
[145.209868] Starting dynamic subtest: rcs0
[146.289827] Dynamic subtest rcs0: SUCCESS (1.080s)
[146.302088] Starting dynamic subtest: bcs0
[147.375138] Dynamic subtest bcs0: SUCCESS (1.084s)
[147.384065] Starting dynamic subtest: vcs0
[148.465657] Dynamic subtest vcs0: SUCCESS (1.090s)
[148.477587] Starting dynamic subtest: vcs1
[149.552051] Dynamic subtest vcs1: SUCCESS (1.085s)
[149.564141] Starting dynamic subtest: vecs0
[150.641479] Dynamic subtest vecs0: SUCCESS (1.088s)
[150.652089] Starting dynamic subtest: ccs0
[151.728058] Dynamic subtest ccs0: SUCCESS (1.085s)
[151.730905] Subtest exec-single-timeline: SUCCESS (6.519s)
[151.914070] [019/131] (864s left) perf (blocking)
[152.027314] Starting subtest: blocking
[152.029394] Starting dynamic subtest: 0-rcs0
[162.058034] Dynamic subtest 0-rcs0: SUCCESS (10.032s)
[162.067046] Starting dynamic subtest: 1-vcs1
[172.080032] Dynamic subtest 1-vcs1: SUCCESS (10.021s)
[172.082625] Subtest blocking: SUCCESS (20.054s)
[172.123275] [020/131] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[172.229455] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[172.233966] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[172.324898] [021/131] (843s left) gem_exec_balancer (nop)
[172.393489] Starting subtest: nop
[219.026106] Subtest nop: SUCCESS (46.631s)
[219.329608] [022/131] (796s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[219.426106] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[219.428462] Starting dynamic subtest: pipe-A-default-mode
[222.200812] Dynamic subtest pipe-A-default-mode: SUCCESS (2.773s)
[222.203151] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.774s)
[223.034542] [023/131] (793s left) gem_exec_fence (syncobj-export)
[223.489153] Starting subtest: syncobj-export
[223.496085] Subtest syncobj-export: SUCCESS (0.007s)
[225.015992] [FACT gem_exec_fence (syncobj-export)] new: kernel.kmod_is_loaded.vgem: true
[225.019913] [024/131] (791s left) kms_plane_cursor (primary)
[225.118996] Starting subtest: primary
[225.123625] Starting dynamic subtest: pipe-A-eDP-1-size-64
[227.950268] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.829s)
[227.972742] Starting dynamic subtest: pipe-A-eDP-1-size-128
[230.816430] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.849s)
[230.841475] Starting dynamic subtest: pipe-A-eDP-1-size-256
[233.631642] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.794s)
[233.946064] Starting dynamic subtest: pipe-B-eDP-1-size-64
[237.490439] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.553s)
[237.513460] Starting dynamic subtest: pipe-B-eDP-1-size-128
[240.378575] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.870s)
[240.403294] Starting dynamic subtest: pipe-B-eDP-1-size-256
[243.158432] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.760s)
[243.469550] Starting dynamic subtest: pipe-C-eDP-1-size-64
[246.566386] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.105s)
[246.591168] Starting dynamic subtest: pipe-C-eDP-1-size-128
[249.033552] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.446s)
[249.058295] Starting dynamic subtest: pipe-C-eDP-1-size-256
[251.444324] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.391s)
[251.770562] Starting dynamic subtest: pipe-D-eDP-1-size-64
[254.897773] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.134s)
[254.924736] Starting dynamic subtest: pipe-D-eDP-1-size-128
[257.377764] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.460s)
[257.400768] Starting dynamic subtest: pipe-D-eDP-1-size-256
[259.831621] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.435s)
[260.140208] Subtest primary: SUCCESS (35.017s)
[260.943507] [025/131] (755s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[261.049358] Starting subtest: 4-tiled-16bpp-rotate-270
[261.069099] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[261.189672] [026/131] (755s left) gem_pxp (reject-modify-context-protection-off-1)
[261.303959] Starting subtest: reject-modify-context-protection-off-1
[261.306367] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[261.406078] [027/131] (755s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[261.520366] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[261.524679] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[261.657609] [028/131] (754s left) kms_content_protection (legacy)
[261.820487] Starting subtest: legacy
[261.825412] Subtest legacy: SKIP (0.000s)
[261.967757] [029/131] (754s left) gem_ctx_persistence (engines-persistence)
[262.017970] Starting subtest: engines-persistence
[262.019942] Starting dynamic subtest: rcs0
[262.895114] Dynamic subtest rcs0: SUCCESS (0.876s)
[262.908519] Starting dynamic subtest: bcs0
[263.695778] Dynamic subtest bcs0: SUCCESS (0.798s)
[263.706409] Starting dynamic subtest: vcs0
[264.484339] Dynamic subtest vcs0: SUCCESS (0.786s)
[264.495259] Starting dynamic subtest: vcs1
[265.256314] Dynamic subtest vcs1: SUCCESS (0.770s)
[265.266071] Starting dynamic subtest: vecs0
[266.082396] Dynamic subtest vecs0: SUCCESS (0.824s)
[266.096077] Starting dynamic subtest: ccs0
[266.816914] Dynamic subtest ccs0: SUCCESS (0.733s)
[266.819414] Subtest engines-persistence: SUCCESS (4.799s)
[266.951574] [030/131] (749s left) kms_plane_scaling (planes-downscale-factor-0-75)
[267.057105] Starting subtest: planes-downscale-factor-0-75
[267.059436] Starting dynamic subtest: pipe-A
[267.080517] Dynamic subtest pipe-A: SKIP (0.017s)
[267.089900] Starting dynamic subtest: pipe-B
[267.111793] Dynamic subtest pipe-B: SKIP (0.028s)
[267.121090] Starting dynamic subtest: pipe-C
[267.139163] Dynamic subtest pipe-C: SKIP (0.029s)
[267.146594] Starting dynamic subtest: pipe-D
[267.166971] Dynamic subtest pipe-D: SKIP (0.029s)
[267.170775] Subtest planes-downscale-factor-0-75: SKIP (0.105s)
[267.293145] [031/131] (749s left) kms_getfb (getfb2-accept-ccs)
[267.348200] Starting subtest: getfb2-accept-ccs
[267.350492] Subtest getfb2-accept-ccs: SUCCESS (0.000s)
[267.439786] [032/131] (749s left) api_intel_bb (reset-flags)
[267.483146] Starting subtest: reset-flags
[267.489224] Subtest reset-flags: SUCCESS (0.008s)
[267.617565] [033/131] (749s left) gem_mmap_offset (open-flood)
[267.661031] Starting subtest: open-flood
[289.148986] Subtest open-flood: SUCCESS (21.490s)
[289.276911] [034/131] (727s left) kms_scaling_modes (scaling-mode-none)
[289.389542] Starting subtest: scaling-mode-none
[289.391533] Starting dynamic subtest: pipe-A-eDP-1
[289.502189] Dynamic subtest pipe-A-eDP-1: SKIP (0.110s)
[289.510646] Starting dynamic subtest: pipe-B-eDP-1
[289.557251] Dynamic subtest pipe-B-eDP-1: SKIP (0.053s)
[289.568240] Starting dynamic subtest: pipe-C-eDP-1
[289.610102] Dynamic subtest pipe-C-eDP-1: SKIP (0.052s)
[289.617693] Starting dynamic subtest: pipe-D-eDP-1
[289.660866] Dynamic subtest pipe-D-eDP-1: SKIP (0.050s)
[289.664799] Subtest scaling-mode-none: SKIP (0.269s)
[289.768035] [035/131] (726s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[289.824623] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[289.826518] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[289.919784] [036/131] (726s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[290.018527] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[291.232049] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.214s)
[291.490533] [037/131] (725s left) gem_exec_whisper (basic-forked)
[291.542152] Starting subtest: basic-forked
[300.885815] Subtest basic-forked: SUCCESS (9.339s)
[301.072210] [038/131] (715s left) gem_softpin (noreloc-s3)
[301.130485] Starting subtest: noreloc-S3
[321.475099] Subtest noreloc-S3: SUCCESS (5.407s)
[321.590332] [039/131] (695s left) kms_flip (dpms-off-confusion)
[321.695964] Starting subtest: dpms-off-confusion
[321.698252] Starting dynamic subtest: A-eDP1
[330.444517] Dynamic subtest A-eDP1: SUCCESS (8.689s)
[330.455498] Starting dynamic subtest: B-eDP1
[339.124451] Dynamic subtest B-eDP1: SUCCESS (8.658s)
[339.135252] Starting dynamic subtest: C-eDP1
[347.859654] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[347.873225] Starting dynamic subtest: D-eDP1
[356.587697] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[356.589960] Subtest dpms-off-confusion: SUCCESS (34.804s)
[357.747701] [040/131] (659s left) kms_frontbuffer_tracking (fbc-stridechange)
[357.843562] Starting subtest: fbc-stridechange
[361.159172] Subtest fbc-stridechange: SUCCESS (3.319s)
[362.322972] [041/131] (654s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[362.411448] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[362.413687] Starting dynamic subtest: pipe-A-eDP-1
[362.461239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.049s)
[362.470871] Starting dynamic subtest: pipe-B-eDP-1
[362.510625] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.049s)
[362.519586] Starting dynamic subtest: pipe-C-eDP-1
[362.559096] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.048s)
[362.568520] Starting dynamic subtest: pipe-D-eDP-1
[362.608681] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.049s)
[362.610966] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.197s)
[364.759428] [042/131] (652s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[364.853354] Starting subtest: y-tiled-64bpp-rotate-270
[364.857412] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[364.965582] [043/131] (652s left) kms_dsc (dsc-with-output-formats-with-bpc)
[365.049212] Starting subtest: dsc-with-output-formats-with-bpc
[365.108423] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[365.145208] [044/131] (651s left) kms_pm_rpm (pm-caching)
[366.889840] Starting subtest: pm-caching
[366.895276] Subtest pm-caching: SKIP (0.000s)
[367.402259] [045/131] (649s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[367.490507] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[367.492860] Starting dynamic subtest: pipe-A-eDP-1
[367.515755] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[367.524986] Starting dynamic subtest: pipe-B-eDP-1
[367.546593] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.555444] Starting dynamic subtest: pipe-C-eDP-1
[367.578287] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.588223] Starting dynamic subtest: pipe-D-eDP-1
[367.610257] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.614635] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.005s)
[369.661632] [046/131] (647s left) kms_addfb_basic (bo-too-small)
[369.754251] Starting subtest: bo-too-small
[369.756548] Subtest bo-too-small: SUCCESS (0.000s)
[369.882324] [047/131] (647s left) kms_psr (psr-cursor-blt)
[369.976709] Starting subtest: psr-cursor-blt
[369.978934] Starting dynamic subtest: eDP-1
[371.736631] Dynamic subtest eDP-1: SUCCESS (1.759s)
[371.738940] Subtest psr-cursor-blt: SUCCESS (1.760s)
[372.599677] [048/131] (644s left) kms_vblank (wait-forked-hang)
[372.684367] Starting subtest: wait-forked-hang
[372.686659] Starting dynamic subtest: pipe-A-eDP-1
[399.544513] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.846s)
[399.558855] Starting dynamic subtest: pipe-D-eDP-1
[424.560509] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.010s)
[424.562773] Subtest wait-forked-hang: SUCCESS (51.862s)
[425.354294] [049/131] (591s left) kms_addfb_basic (invalid-get-prop)
[425.410097] Starting subtest: invalid-get-prop
[425.412366] Subtest invalid-get-prop: SUCCESS (0.000s)
[425.577823] [050/131] (591s left) perf_pmu (render-node-busy-idle)
[425.659772] Starting subtest: render-node-busy-idle
[425.662238] Starting dynamic subtest: rcs0
[426.345586] Dynamic subtest rcs0: SUCCESS (0.685s)
[426.357045] Starting dynamic subtest: bcs0
[427.012990] Dynamic subtest bcs0: SUCCESS (0.666s)
[427.023118] Starting dynamic subtest: vcs0
[427.714939] Dynamic subtest vcs0: FAIL (0.651s)
[427.724478] Starting dynamic subtest: vcs1
[429.476967] Dynamic subtest vcs1: FAIL (1.744s)
[429.487768] Starting dynamic subtest: vecs0
[431.459605] Dynamic subtest vecs0: FAIL (1.982s)
[431.471116] Starting dynamic subtest: ccs0
[433.510351] Dynamic subtest ccs0: FAIL (2.051s)
[433.512691] Subtest render-node-busy-idle: FAIL (7.786s)
[433.551333] [051/131] (583s left) i915_query (hwconfig_table)
[433.634126] Starting subtest: hwconfig_table
[433.940970] Subtest hwconfig_table: SUCCESS (0.002s)
[433.982935] [052/131] (583s left) i915_module_load (reload-with-fault-injection)
[434.016238] Starting subtest: reload-with-fault-injection
[464.596646] Subtest reload-with-fault-injection: SUCCESS (30.579s)
[464.625308] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[464.625990] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[464.629015] [053/131] (552s left) gem_ccs (ctrl-surf-copy-new-ctx)
[466.078863] Starting subtest: ctrl-surf-copy-new-ctx
[466.083654] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[466.176807] [FACT gem_ccs (ctrl-surf-copy-new-ctx)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[466.178792] [FACT gem_ccs (ctrl-surf-copy-new-ctx)] new: kernel.kmod_is_loaded.i915: true
[466.182584] [054/131] (551s left) i915_drm_fdinfo (virtual-busy-idle)
[466.221097] Starting subtest: virtual-busy-idle
[466.225536] Subtest virtual-busy-idle: SKIP (0.000s)
[466.290365] [055/131] (551s left) syncobj_wait (reset-multiple-signaled)
[466.351280] Starting subtest: reset-multiple-signaled
[466.353520] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[466.460208] [056/131] (551s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[471.513151] Starting subtest: fbc-pr-cursor-plane-update-sf
[471.518051] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.002s)
[472.354744] [057/131] (545s left) gem_exec_reloc (basic-write-read-noreloc)
[472.417316] Subtest basic-write-read-noreloc: SKIP (0.000s)
[472.491336] [058/131] (545s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[472.587648] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[472.589954] Starting dynamic subtest: pipe-A-eDP-1
[472.599302] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[472.609081] Starting dynamic subtest: pipe-B-eDP-1
[472.618148] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[472.626436] Starting dynamic subtest: pipe-C-eDP-1
[472.635264] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[472.645431] Starting dynamic subtest: pipe-D-eDP-1
[472.653612] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[472.657754] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[474.714820] [059/131] (543s left) prime_vgem (fence-wait)
[474.787760] Starting subtest: fence-wait
[474.790110] Starting dynamic subtest: rcs0
[475.824978] Dynamic subtest rcs0: SUCCESS (1.036s)
[475.836577] Starting dynamic subtest: bcs0
[476.886715] Dynamic subtest bcs0: SUCCESS (1.060s)
[476.896692] Starting dynamic subtest: vcs0
[477.933685] Dynamic subtest vcs0: SUCCESS (1.044s)
[477.944178] Starting dynamic subtest: vcs1
[478.978750] Dynamic subtest vcs1: SUCCESS (1.043s)
[478.990146] Starting dynamic subtest: vecs0
[480.023073] Dynamic subtest vecs0: SUCCESS (1.043s)
[480.032362] Starting dynamic subtest: ccs0
[481.067098] Dynamic subtest ccs0: SUCCESS (1.039s)
[481.070282] Subtest fence-wait: SUCCESS (6.278s)
[481.190477] [060/131] (536s left) kms_flip (2x-plain-flip-interruptible)
[481.301881] Starting subtest: 2x-plain-flip-interruptible
[481.313630] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[481.386361] [061/131] (536s left) kms_plane (plane-panning-bottom-right-suspend)
[481.481468] Starting subtest: plane-panning-bottom-right-suspend
[481.483788] Starting dynamic subtest: pipe-A
[498.798401] Dynamic subtest pipe-A: SUCCESS (2.799s)
[498.807685] Starting dynamic subtest: pipe-B
[516.779531] Dynamic subtest pipe-B: SUCCESS (3.296s)
[516.781429] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.097s)
[517.638252] [062/131] (500s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[517.748963] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[517.753602] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[517.856484] [063/131] (500s left) gem_userptr_blits (map-fixed-invalidate)
[517.926932] Starting subtest: map-fixed-invalidate
[517.931408] Subtest map-fixed-invalidate: SKIP (0.000s)
[518.070220] [064/131] (499s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[518.173988] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[518.178477] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[518.287318] [065/131] (499s left) gem_exec_reloc (basic-write-read-active)
[518.341753] Subtest basic-write-read-active: SKIP (0.000s)
[518.422219] [066/131] (499s left) gem_ctx_engines (execute-oneforall)
[518.486737] Starting subtest: execute-oneforall
[519.014229] Subtest execute-oneforall: SUCCESS (0.520s)
[520.060538] [067/131] (497s left) syncobj_timeline (invalid-query-illegal-handle)
[520.115600] Starting subtest: invalid-query-illegal-handle
[520.117847] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[520.207910] [068/131] (497s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[520.303784] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[520.306175] Starting dynamic subtest: pipe-A-eDP-1
[520.327124] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[520.336694] Starting dynamic subtest: pipe-B-eDP-1
[520.355543] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[520.364012] Starting dynamic subtest: pipe-C-eDP-1
[520.383121] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[520.391522] Starting dynamic subtest: pipe-D-eDP-1
[520.410946] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[520.413127] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[522.448179] [069/131] (495s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[522.551607] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[522.555930] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[522.661785] [070/131] (495s left) gem_eio (wait-wedge-immediate)
[522.888944] Starting subtest: wait-wedge-immediate
[523.995910] Subtest wait-wedge-immediate: SUCCESS (1.097s)
[524.132571] [071/131] (494s left) sysfs_heartbeat_interval (invalid)
[524.194725] Starting subtest: invalid
[524.197230] Starting dynamic subtest: vecs0
[524.199643] Dynamic subtest vecs0: SUCCESS (0.000s)
[524.209838] Starting dynamic subtest: ccs0
[524.211833] Dynamic subtest ccs0: SUCCESS (0.000s)
[524.220295] Starting dynamic subtest: vcs0
[524.222245] Dynamic subtest vcs0: SUCCESS (0.000s)
[524.230327] Starting dynamic subtest: bcs0
[524.232269] Dynamic subtest bcs0: SUCCESS (0.000s)
[524.240703] Starting dynamic subtest: rcs0
[524.242978] Dynamic subtest rcs0: SUCCESS (0.000s)
[524.251752] Starting dynamic subtest: vcs1
[524.253669] Dynamic subtest vcs1: SUCCESS (0.000s)
[524.255629] Subtest invalid: SUCCESS (0.004s)
[524.294699] [072/131] (493s left) perf (mi-rpc)
[524.405443] Starting subtest: mi-rpc
[524.409663] Subtest mi-rpc: SKIP (0.000s)
[524.449986] [073/131] (493s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[524.554583] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[529.169883] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.595s)
[530.274152] [074/131] (488s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[530.320637] Starting subtest: wait-all-for-submit-delayed-submit
[530.424717] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[530.500396] [075/131] (487s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[530.609548] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[530.613924] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[530.718577] [076/131] (487s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[530.825683] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[530.830516] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[530.927664] [077/131] (487s left) api_intel_allocator (fork-simple-stress-signal)
[530.995018] Starting subtest: fork-simple-stress-signal
[536.407709] Subtest fork-simple-stress-signal: SUCCESS (5.400s)
[536.534980] [078/131] (481s left) gem_exec_fence (syncobj-wait)
[536.981198] Starting subtest: syncobj-wait
[538.918729] Subtest syncobj-wait: SUCCESS (1.933s)
[539.302314] [079/131] (479s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[539.415303] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[539.419879] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[539.512112] [080/131] (479s left) gem_lmem_swapping (verify)
[539.558943] Subtest verify: SKIP (0.000s)
[539.603853] [081/131] (479s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[539.671969] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[539.776211] [082/131] (478s left) kms_pm_rpm (fences)
[542.116354] Starting subtest: fences
[542.121894] Subtest fences: SKIP (0.000s)
[542.472293] [083/131] (476s left) syncobj_timeline (wait-any-interrupted)
[542.528929] Starting subtest: wait-any-interrupted
[542.628448] Subtest wait-any-interrupted: SUCCESS (0.101s)
[542.704523] [084/131] (476s left) gem_exec_params (readonly)
[542.744818] Starting subtest: readonly
[542.750176] Subtest readonly: SUCCESS (0.003s)
[542.856709] [085/131] (475s left) kms_lease (simple-lease)
[542.957756] Starting subtest: simple-lease
[542.960205] Starting dynamic subtest: pipe-A-eDP-1
[543.479399] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.519s)
[543.493189] Starting dynamic subtest: pipe-B-eDP-1
[544.913469] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.429s)
[544.928863] Starting dynamic subtest: pipe-C-eDP-1
[546.397949] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.482s)
[546.408933] Starting dynamic subtest: pipe-D-eDP-1
[547.777719] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.377s)
[547.780094] Subtest simple-lease: SUCCESS (4.815s)
[548.578535] [086/131] (470s left) gen3_render_linear_blits
[548.686649] [087/131] (470s left) api_intel_bb (crc32)
[548.745381] Starting subtest: crc32
[548.747250] Starting dynamic subtest: rcs0-smem0
[549.024878] Dynamic subtest rcs0-smem0: SUCCESS (0.279s)
[549.038127] Starting dynamic subtest: bcs0-smem0
[549.350592] Dynamic subtest bcs0-smem0: SUCCESS (0.323s)
[549.363059] Starting dynamic subtest: vcs0-smem0
[549.645111] Dynamic subtest vcs0-smem0: SUCCESS (0.293s)
[549.677555] Starting dynamic subtest: vcs1-smem0
[549.960423] Dynamic subtest vcs1-smem0: SUCCESS (0.313s)
[549.970572] Starting dynamic subtest: vecs0-smem0
[550.263281] Dynamic subtest vecs0-smem0: SUCCESS (0.301s)
[550.275924] Starting dynamic subtest: ccs0-smem0
[550.602402] Dynamic subtest ccs0-smem0: SUCCESS (0.337s)
[550.605316] Subtest crc32: SUCCESS (1.859s)
[550.726819] [088/131] (468s left) syncobj_wait (invalid-reset-zero-handles)
[550.778955] Starting subtest: invalid-reset-zero-handles
[550.781281] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[550.887756] [089/131] (468s left) kms_display_modes (extended-mode-basic)
[550.971976] Starting subtest: extended-mode-basic
[550.976580] Subtest extended-mode-basic: SKIP (0.000s)
[551.022377] [090/131] (467s left) i915_suspend (fence-restore-tiled2untiled)
[551.073189] Starting subtest: fence-restore-tiled2untiled
[551.077478] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[551.180472] [091/131] (467s left) kms_writeback (writeback-invalid-parameters)
[551.271792] Subtest writeback-invalid-parameters: SKIP (0.000s)
[551.316284] [092/131] (467s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[551.418058] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[558.630742] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.219s)
[558.752236] [093/131] (460s left) syncobj_timeline (32bits-limit)
[558.815504] Starting subtest: 32bits-limit
[558.817909] Subtest 32bits-limit: SUCCESS (0.001s)
[558.934511] [094/131] (460s left) gem_exec_parallel (basic)
[558.990493] Starting subtest: basic
[558.992660] Starting dynamic subtest: rcs0
[560.422632] Dynamic subtest rcs0: SUCCESS (1.432s)
[560.434055] Starting dynamic subtest: bcs0
[561.885469] Dynamic subtest bcs0: SUCCESS (1.462s)
[561.897548] Starting dynamic subtest: vcs0
[563.857118] Dynamic subtest vcs0: SUCCESS (1.969s)
[563.870055] Starting dynamic subtest: vcs1
[565.906906] Dynamic subtest vcs1: SUCCESS (2.047s)
[565.922619] Starting dynamic subtest: vecs0
[567.954094] Dynamic subtest vecs0: SUCCESS (2.045s)
[567.966772] Starting dynamic subtest: ccs0
[569.455398] Dynamic subtest ccs0: SUCCESS (1.500s)
[569.457994] Subtest basic: SUCCESS (10.465s)
[569.638103] [095/131] (449s left) kms_joiner (basic-force-ultra-joiner)
[569.743491] Starting subtest: basic-force-ultra-joiner
[569.747580] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[569.805918] [096/131] (449s left) kms_chamelium_color (ctm-red-to-blue)
[569.889417] Subtest ctm-red-to-blue: SKIP (0.000s)
[569.939587] [097/131] (449s left) gem_exec_schedule (submit-late-slice)
[570.010065] Starting subtest: submit-late-slice
[570.012459] Starting dynamic subtest: rcs0
[570.048508] Dynamic subtest rcs0: SUCCESS (0.044s)
[570.060657] Starting dynamic subtest: bcs0
[570.089730] Dynamic subtest bcs0: SUCCESS (0.041s)
[570.098867] Starting dynamic subtest: vcs0
[570.122898] Dynamic subtest vcs0: SUCCESS (0.032s)
[570.132089] Starting dynamic subtest: vcs1
[570.155802] Dynamic subtest vcs1: SUCCESS (0.033s)
[570.165373] Starting dynamic subtest: vecs0
[570.188244] Dynamic subtest vecs0: SUCCESS (0.032s)
[570.201661] Starting dynamic subtest: ccs0
[570.228543] Dynamic subtest ccs0: SUCCESS (0.040s)
[570.230891] Subtest submit-late-slice: SUCCESS (0.224s)
[572.029681] [098/131] (447s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[572.134909] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[573.423415] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.290s)
[573.596132] [099/131] (445s left) kms_chamelium_hpd (hdmi-hpd)
[573.983337] Subtest hdmi-hpd: SKIP (0.000s)
[574.770439] [100/131] (444s left) gem_userptr_blits (userfault)
[574.828174] Starting subtest: userfault
[574.830218] Subtest userfault: SUCCESS (0.006s)
[574.967264] [101/131] (444s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[575.021745] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[575.085126] [102/131] (444s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[575.183795] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[575.188116] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[575.305208] [103/131] (444s left) kms_psr (fbc-pr-no-drrs)
[575.402732] Starting subtest: fbc-pr-no-drrs
[575.406567] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[575.472588] [104/131] (444s left) kms_frontbuffer_tracking (psr-2p-rte)
[575.566436] Starting subtest: psr-2p-rte
[575.570877] Subtest psr-2p-rte: SKIP (0.000s)
[575.680227] [105/131] (443s left) kms_psr (pr-cursor-render)
[575.777880] Starting subtest: pr-cursor-render
[575.781737] Subtest pr-cursor-render: SKIP (0.000s)
[575.852922] [106/131] (443s left) gem_wait (wait)
[575.925439] Starting subtest: wait
[575.927587] Starting dynamic subtest: all-engines
[577.937315] Dynamic subtest all-engines: SUCCESS (2.009s)
[577.950568] Starting dynamic subtest: rcs0
[578.981872] Dynamic subtest rcs0: SUCCESS (1.044s)
[578.994019] Starting dynamic subtest: bcs0
[580.027985] Dynamic subtest bcs0: SUCCESS (1.044s)
[580.038962] Starting dynamic subtest: vcs0
[581.074156] Dynamic subtest vcs0: SUCCESS (1.044s)
[581.086399] Starting dynamic subtest: vcs1
[582.120447] Dynamic subtest vcs1: SUCCESS (1.044s)
[582.131225] Starting dynamic subtest: vecs0
[583.165965] Dynamic subtest vecs0: SUCCESS (1.044s)
[583.177542] Starting dynamic subtest: ccs0
[584.213000] Dynamic subtest ccs0: SUCCESS (1.045s)
[584.215461] Subtest wait: SUCCESS (8.286s)
[584.409912] [107/131] (435s left) gem_exec_async (forked-writes)
[584.471696] Starting subtest: forked-writes
[584.473662] Starting dynamic subtest: rcs0
[584.506031] Dynamic subtest rcs0: SUCCESS (0.036s)
[584.519996] Starting dynamic subtest: bcs0
[584.530666] Dynamic subtest bcs0: SUCCESS (0.024s)
[584.540776] Starting dynamic subtest: vcs0
[584.550733] Dynamic subtest vcs0: SUCCESS (0.020s)
[584.563316] Starting dynamic subtest: vcs1
[584.575992] Dynamic subtest vcs1: SUCCESS (0.024s)
[584.587053] Starting dynamic subtest: vecs0
[584.597989] Dynamic subtest vecs0: SUCCESS (0.021s)
[584.609292] Starting dynamic subtest: ccs0
[584.621013] Dynamic subtest ccs0: SUCCESS (0.022s)
[584.623196] Subtest forked-writes: SUCCESS (0.152s)
[584.870281] [108/131] (434s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[584.976248] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[584.980623] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[585.078200] [109/131] (434s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[585.168568] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[592.794760] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.627s)
[592.919147] [110/131] (426s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[593.056393] Starting subtest: 2x-long-cursor-vs-flip-legacy
[593.060742] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s)
[593.189226] [111/131] (426s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[593.285255] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[593.289489] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[593.373310] [112/131] (426s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[593.427022] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[593.533345] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[593.607760] [113/131] (426s left) gen9_exec_parse (shadow-peek)
[593.673368] Subtest shadow-peek: SKIP (0.000s)
[593.742955] [114/131] (426s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[593.796836] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[593.888956] [115/131] (426s left) kms_psr (fbc-psr2-primary-render)
[593.991005] Starting subtest: fbc-psr2-primary-render
[593.992915] Starting dynamic subtest: eDP-1
[593.997050] Dynamic subtest eDP-1: SKIP (0.000s)
[594.001080] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[594.059781] [116/131] (425s left) perf_pmu (all-busy-check-all)
[594.098108] Starting subtest: all-busy-check-all
[595.922268] Subtest all-busy-check-all: SUCCESS (1.823s)
[596.043186] [117/131] (424s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[596.229697] Starting subtest: cursor-rapid-movement-64x21
[596.275810] Subtest cursor-rapid-movement-64x21: SKIP (0.040s)
[596.533216] [118/131] (423s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[596.635556] Starting subtest: psr-shrfb-scaledprimary
[602.318839] Subtest psr-shrfb-scaledprimary: SUCCESS (5.685s)
[602.475857] [119/131] (417s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[602.587006] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[602.591330] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[602.710343] [120/131] (417s left) kms_flip (wf_vblank-ts-check)
[602.810035] Starting subtest: wf_vblank-ts-check
[602.812368] Starting dynamic subtest: A-eDP1
[611.716497] Dynamic subtest A-eDP1: SUCCESS (8.903s)
[611.732305] Starting dynamic subtest: B-eDP1
[620.631638] Dynamic subtest B-eDP1: SUCCESS (8.917s)
[620.641973] Starting dynamic subtest: C-eDP1
[629.540424] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[629.552694] Starting dynamic subtest: D-eDP1
[638.471980] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[638.477127] Subtest wf_vblank-ts-check: SUCCESS (35.670s)
[639.698718] [121/131] (380s left) kms_chamelium_audio (hdmi-audio)
[640.091455] Subtest hdmi-audio: SKIP (0.000s)
[640.898924] [122/131] (379s left) kms_flip (2x-flip-vs-expired-vblank)
[640.998068] Starting subtest: 2x-flip-vs-expired-vblank
[641.008618] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[641.124863] [123/131] (379s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[641.177128] Starting subtest: multi-wait-for-submit-submitted-signaled
[641.179551] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[641.293828] [124/131] (379s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[641.400560] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[645.363641] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.968s)
[646.509381] [125/131] (373s left) kms_async_flips (test-cursor-atomic)
[646.609138] Starting subtest: test-cursor-atomic
[646.613589] Subtest test-cursor-atomic: SKIP (0.000s)
[647.805158] [126/131] (372s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[647.893921] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[647.896235] Starting dynamic subtest: pipe-A-default-mode
[648.195581] Dynamic subtest pipe-A-default-mode: SKIP (0.297s)
[648.200335] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.298s)
[649.035263] [127/131] (371s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[649.424892] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[650.241186] [128/131] (370s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[650.299863] Starting subtest: yf-tiled-to-vebox-x-tiled
[650.304417] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[650.485009] [129/131] (370s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[650.544945] Starting subtest: multi-wait-all-for-submit-submitted
[650.653607] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[650.731402] [130/131] (369s left) gem_exec_schedule (smoketest)
[650.914654] Starting subtest: smoketest
[650.916909] Starting dynamic subtest: rcs0
[656.461225] Dynamic subtest rcs0: SUCCESS (5.491s)
[656.472502] Starting dynamic subtest: bcs0
[661.979706] Dynamic subtest bcs0: SUCCESS (5.516s)
[661.997170] Starting dynamic subtest: vcs0
[667.465928] Dynamic subtest vcs0: SUCCESS (5.492s)
[667.477315] Starting dynamic subtest: vcs1
[672.990062] Dynamic subtest vcs1: SUCCESS (5.513s)
[673.007155] Starting dynamic subtest: vecs0
[678.488457] Dynamic subtest vecs0: SUCCESS (5.503s)
[678.506055] Starting dynamic subtest: ccs0
[683.995409] Dynamic subtest ccs0: SUCCESS (5.507s)
[683.997428] Subtest smoketest: SUCCESS (33.027s)
[684.196083] [131/131] (336s left) gem_pread (snoop)
[684.251691] Subtest snoop: SKIP (0.000s)
[684.320046] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: drm_read
results: parsing output: 4/ for test: kms_sequence
results: parsing output: 5/ for test: gem_softpin
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_ctx_shared
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: gem_exec_fence
results: parsing output: 23/ for test: kms_plane_cursor
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_pxp
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_content_protection
results: parsing output: 28/ for test: gem_ctx_persistence
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: kms_getfb
results: parsing output: 31/ for test: api_intel_bb
results: parsing output: 32/ for test: gem_mmap_offset
results: parsing output: 33/ for test: kms_scaling_modes
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: gem_softpin
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_dsc
results: parsing output: 43/ for test: kms_pm_rpm
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_addfb_basic
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_vblank
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: i915_query
results: parsing output: 51/ for test: i915_module_load
results: parsing output: 52/ for test: gem_ccs
results: parsing output: 53/ for test: i915_drm_fdinfo
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: prime_vgem
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: gem_ctx_engines
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: sysfs_heartbeat_interval
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: api_intel_allocator
results: parsing output: 77/ for test: gem_exec_fence
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_lmem_swapping
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_pm_rpm
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_lease
results: parsing output: 85/ for test: gen3_render_linear_blits
results: parsing output: 86/ for test: api_intel_bb
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_display_modes
results: parsing output: 89/ for test: i915_suspend
results: parsing output: 90/ for test: kms_writeback
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: gem_exec_parallel
results: parsing output: 94/ for test: kms_joiner
results: parsing output: 95/ for test: kms_chamelium_color
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_chamelium_hpd
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: gem_wait
results: parsing output: 106/ for test: gem_exec_async
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: gem_fenced_exec_thrash
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: perf_pmu
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_chamelium_audio
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_async_flips
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: gem_pread
Done.