[57.113601] Initializing watchdogs
[57.113651]   /dev/watchdog0
[57.127886] [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]
[57.132276] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.134526] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.137979] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[57.309089] Starting subtest: dp-mst-lic-type-0-hdcp14
[57.313768] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[57.442303] [002/133] (960s left) core_getversion (all-cards)
[57.491839] Starting subtest: all-cards
[57.498611] Subtest all-cards: SUCCESS (0.009s)
[57.552036] [003/133] (960s left) kms_atomic_interruptible (legacy-dpms)
[57.640104] Starting subtest: legacy-dpms
[57.642350] Starting dynamic subtest: pipe-A-eDP-1
[65.057402] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.398s)
[65.060218] Subtest legacy-dpms: SUCCESS (7.399s)
[65.913673] [004/133] (951s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[66.009261] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[66.022884] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[66.086635] [005/133] (951s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[66.182064] Starting subtest: plane-primary-toggle-with-vblank-wait
[66.184276] Starting dynamic subtest: pipe-A-eDP-1
[66.355877] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[66.660311] Starting dynamic subtest: pipe-B-eDP-1
[67.610566] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.955s)
[67.908592] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.724s)
[68.777864] [006/133] (949s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[68.884703] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[68.889252] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[68.992698] [007/133] (948s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[69.086851] Starting subtest: fbc-psr2-primary-mmap-cpu
[69.089172] Starting dynamic subtest: eDP-1
[69.093628] Dynamic subtest eDP-1: SKIP (0.000s)
[69.098460] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[69.168781] [008/133] (948s left) perf (invalid-oa-exponent)
[69.296600] Starting subtest: invalid-oa-exponent
[69.309757] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[69.355045] [009/133] (948s left) gem_eio (create-ext)
[69.494122] Starting subtest: create-ext
[69.670690] Subtest create-ext: SUCCESS (0.176s)
[69.811118] [010/133] (948s left) kms_color (invalid-degamma-lut-sizes)
[69.903334] Starting subtest: invalid-degamma-lut-sizes
[69.905351] Starting dynamic subtest: pipe-A
[70.192786] Dynamic subtest pipe-A: SUCCESS (0.289s)
[70.201356] Starting dynamic subtest: pipe-B
[70.203672] Dynamic subtest pipe-B: SUCCESS (0.000s)
[70.211221] Starting dynamic subtest: pipe-C
[70.213516] Dynamic subtest pipe-C: SUCCESS (0.000s)
[70.220893] Starting dynamic subtest: pipe-D
[70.223228] Dynamic subtest pipe-D: SUCCESS (0.000s)
[70.225188] Subtest invalid-degamma-lut-sizes: SUCCESS (0.291s)
[71.011508] [011/133] (946s left) gem_softpin (allocator-basic)
[71.075486] Starting subtest: allocator-basic
[71.146680] Subtest allocator-basic: SUCCESS (0.072s)
[71.295715] [012/133] (946s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[71.398388] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[71.400511] Starting dynamic subtest: pipe-A-eDP-1
[77.193239] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.798s)
[77.202526] Starting dynamic subtest: pipe-B-eDP-1
[83.841579] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.644s)
[83.844048] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.444s)
[84.728478] [013/133] (933s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[84.829686] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[84.834137] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[84.917598] [014/133] (933s left) kms_psr (pr-primary-render)
[85.002883] Starting subtest: pr-primary-render
[85.007631] Subtest pr-primary-render: SKIP (0.000s)
[85.100081] [015/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[85.191076] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[85.195271] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[85.313224] [016/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[85.418607] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[85.422577] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[85.510429] [017/133] (932s left) gem_ccs (ctrl-surf-copy)
[85.577854] Starting subtest: ctrl-surf-copy
[85.582177] Subtest ctrl-surf-copy: SKIP (0.000s)
[85.714948] [018/133] (932s left) perf (invalid-oa-metric-set-id)
[85.814372] Starting subtest: invalid-oa-metric-set-id
[85.822964] Subtest invalid-oa-metric-set-id: SUCCESS (0.007s)
[85.863019] [019/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[85.963055] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[85.966380] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[86.070347] [020/133] (932s left) gem_pxp (create-regular-buffer)
[86.188645] Starting subtest: create-regular-buffer
[86.190745] Subtest create-regular-buffer: SUCCESS (0.000s)
[86.316977] [021/133] (932s left) gem_eio (in-flight-contexts-10ms)
[86.510356] Starting subtest: in-flight-contexts-10ms
[97.898448] Subtest in-flight-contexts-10ms: SUCCESS (11.385s)
[98.070070] [022/133] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[98.176525] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[104.882665] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.709s)
[105.041520] [023/133] (913s left) gem_exec_schedule (u-fairslice-all)
[105.114472] Starting subtest: u-fairslice-all
[107.166098] Subtest u-fairslice-all: SUCCESS (2.057s)
[107.472453] [024/133] (911s left) core_getstats (basic)
[107.537107] Starting subtest: basic
[107.539539] Subtest basic: SUCCESS (0.000s)
[107.664130] [025/133] (910s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[107.766752] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[107.768997] Starting dynamic subtest: pipe-A-eDP-1
[108.633063] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.861s)
[108.641564] Starting dynamic subtest: pipe-B-eDP-1
[110.271387] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.634s)
[110.280844] Starting dynamic subtest: pipe-C-eDP-1
[111.768407] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.495s)
[111.776646] Starting dynamic subtest: pipe-D-eDP-1
[113.300871] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.531s)
[113.302876] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.526s)
[114.481813] [026/133] (904s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[114.576129] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[114.578412] Starting dynamic subtest: pipe-A-eDP-1
[114.601660] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[114.611986] Starting dynamic subtest: pipe-B-eDP-1
[114.633690] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[114.641900] Starting dynamic subtest: pipe-C-eDP-1
[114.663529] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[114.673466] Starting dynamic subtest: pipe-D-eDP-1
[114.695197] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[114.699198] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[116.754085] [027/133] (901s left) sw_sync (alloc_fence)
[116.793097] Starting subtest: alloc_fence
[116.795427] Subtest alloc_fence: SUCCESS (0.000s)
[116.868791] [028/133] (901s left) i915_pm_rps (basic-api)
[116.938980] Starting subtest: basic-api
[116.943551] Subtest basic-api: SKIP (0.000s)
[117.063770] [029/133] (901s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[117.176218] Starting subtest: cursorB-vs-flipA-toggle
[117.180726] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[117.347277] [030/133] (901s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[117.556952] Starting subtest: cursor-rapid-movement-128x42
[117.603663] Subtest cursor-rapid-movement-128x42: SKIP (0.042s)
[117.811524] [031/133] (900s left) kms_dp_link_training (non-uhbr-sst)
[117.907325] Starting subtest: non-uhbr-sst
[117.914346] Subtest non-uhbr-sst: SKIP (0.000s)
[117.992217] [032/133] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[118.075359] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[118.078885] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[118.184592] [033/133] (900s left) gem_exec_parallel (engines)
[118.239164] Starting subtest: engines
[118.240783] Starting dynamic subtest: basic
[119.913653] Dynamic subtest basic: SUCCESS (1.675s)
[119.922260] Starting dynamic subtest: contexts
[124.331800] Dynamic subtest contexts: SUCCESS (4.416s)
[124.340831] Starting dynamic subtest: fds
[128.190284] Dynamic subtest fds: SUCCESS (3.856s)
[128.199227] Starting dynamic subtest: userptr
[129.690888] Dynamic subtest userptr: SUCCESS (1.500s)
[129.693521] Subtest engines: SUCCESS (11.454s)
[129.893838] [034/133] (889s left) gem_eio (in-flight-immediate)
[130.155552] Starting subtest: in-flight-immediate
[139.107590] Subtest in-flight-immediate: SUCCESS (8.952s)
[139.303209] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[139.306637] [035/133] (879s left) prime_mmap (test_forked)
[139.370326] Starting subtest: test_forked
[139.372601] Starting dynamic subtest: test_forked-smem
[139.410736] Dynamic subtest test_forked-smem: SUCCESS (0.042s)
[139.413110] Subtest test_forked: SUCCESS (0.043s)
[139.521470] [036/133] (879s left) kms_dsc (dsc-with-formats)
[139.626959] Starting subtest: dsc-with-formats
[139.667131] Subtest dsc-with-formats: SKIP (0.001s)
[139.717686] [037/133] (879s left) prime_busy (hang)
[139.777966] Starting subtest: hang
[139.780261] Starting dynamic subtest: rcs0
[165.425332] Dynamic subtest rcs0: SUCCESS (25.644s)
[165.435204] Starting dynamic subtest: bcs0
[172.583103] Dynamic subtest bcs0: SUCCESS (7.158s)
[172.591166] Starting dynamic subtest: vcs0
[179.555929] Dynamic subtest vcs0: SUCCESS (6.971s)
[179.563811] Starting dynamic subtest: vcs1
[186.530659] Dynamic subtest vcs1: SUCCESS (6.976s)
[186.541687] Starting dynamic subtest: vecs0
[193.568067] Dynamic subtest vecs0: SUCCESS (7.036s)
[193.578928] Starting dynamic subtest: ccs0
[207.407185] Dynamic subtest ccs0: SUCCESS (13.836s)
[207.409736] Subtest hang: SUCCESS (67.627s)
[207.565164] [038/133] (811s left) kms_vblank (wait-idle)
[207.662218] Starting subtest: wait-idle
[207.664536] Starting dynamic subtest: pipe-A-eDP-1
[209.430873] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.768s)
[209.446454] Starting dynamic subtest: pipe-D-eDP-1
[211.875653] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.440s)
[211.877648] Subtest wait-idle: SUCCESS (4.211s)
[212.707200] [039/133] (806s left) kms_pm_rpm (package-g7)
[214.227317] Starting subtest: package-g7
[214.232390] Subtest package-g7: SKIP (0.000s)
[214.934401] [040/133] (804s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[215.053639] Starting subtest: flip-vs-cursor-varying-size
[223.691300] Subtest flip-vs-cursor-varying-size: SUCCESS (8.639s)
[224.545512] [041/133] (794s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[224.646643] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[231.984478] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.340s)
[232.140394] [042/133] (787s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[232.196541] Starting subtest: single-wait-all-for-submit-signaled
[232.198868] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[232.313889] [043/133] (786s left) perf (gen12-group-exclusive-stream-ctx-handle)
[232.415500] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[232.462579] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.049s)
[232.514452] [044/133] (786s left) gem_wait (busy)
[233.856050] Starting subtest: busy
[233.858738] Starting dynamic subtest: all-engines
[235.925720] Dynamic subtest all-engines: SUCCESS (2.068s)
[235.937448] Starting dynamic subtest: rcs0
[236.468151] Dynamic subtest rcs0: SUCCESS (0.542s)
[236.477920] Starting dynamic subtest: bcs0
[237.008118] Dynamic subtest bcs0: SUCCESS (0.539s)
[237.018929] Starting dynamic subtest: vcs0
[238.932745] Dynamic subtest vcs0: SUCCESS (1.922s)
[238.944088] Starting dynamic subtest: vcs1
[240.916793] Dynamic subtest vcs1: SUCCESS (1.982s)
[240.926059] Starting dynamic subtest: vecs0
[242.900939] Dynamic subtest vecs0: SUCCESS (1.981s)
[242.912104] Starting dynamic subtest: ccs0
[243.441905] Dynamic subtest ccs0: SUCCESS (0.541s)
[243.444290] Subtest busy: SUCCESS (9.587s)
[243.656948] [045/133] (775s left) gen9_exec_parse (bb-secure)
[243.720060] Subtest bb-secure: SKIP (0.000s)
[243.784393] [046/133] (775s left) kms_cursor_edge_walk (128x128-right-edge)
[243.889187] Starting subtest: 128x128-right-edge
[243.891402] Starting dynamic subtest: pipe-A-eDP-1
[247.332777] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s)
[247.341871] Starting dynamic subtest: pipe-D-eDP-1
[250.463208] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[250.465524] Subtest 128x128-right-edge: SUCCESS (6.576s)
[251.274574] [047/133] (768s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[251.366450] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[251.370506] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[251.485285] [048/133] (768s left) prime_mmap (test_forked_cpu_write)
[251.535285] Starting subtest: test_forked_cpu_write
[251.537459] Starting dynamic subtest: test_forked_cpu_write-smem
[251.542100] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[251.544458] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[251.678605] [049/133] (767s left) kms_addfb_basic (small-bo)
[251.778896] Starting subtest: small-bo
[251.780806] Subtest small-bo: SUCCESS (0.000s)
[251.901405] [050/133] (767s left) kms_chamelium_audio (dp-audio)
[252.284088] Subtest dp-audio: SKIP (0.000s)
[253.066558] [051/133] (766s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[253.458244] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[254.285313] [052/133] (765s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[254.397143] Starting subtest: psr-shrfb-scaledprimary
[260.216906] Subtest psr-shrfb-scaledprimary: SUCCESS (5.823s)
[260.398476] [053/133] (759s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[260.505424] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[260.509577] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[260.588917] [054/133] (759s left) perf (i915-ref-count)
[260.674759] Starting subtest: i915-ref-count
[260.697358] Subtest i915-ref-count: SUCCESS (0.024s)
[260.755981] [055/133] (759s left) kms_joiner (invalid-modeset-force-big-joiner)
[260.855960] Starting subtest: invalid-modeset-force-big-joiner
[260.860435] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[260.951876] [056/133] (758s left) kms_cursor_crc (cursor-alpha-opaque)
[261.054076] Starting subtest: cursor-alpha-opaque
[261.056539] Starting dynamic subtest: pipe-A-eDP-1
[261.650612] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.597s)
[261.664582] Starting dynamic subtest: pipe-D-eDP-1
[262.899674] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[262.902098] Subtest cursor-alpha-opaque: SUCCESS (1.848s)
[263.792198] [057/133] (756s left) kms_legacy_colorkey (basic)
[263.901993] Starting subtest: basic
[263.904198] Starting dynamic subtest: pipe-A
[263.944809] Dynamic subtest pipe-A: SUCCESS (0.045s)
[263.956255] Starting dynamic subtest: pipe-B
[263.958577] Dynamic subtest pipe-B: SUCCESS (0.001s)
[263.966702] Starting dynamic subtest: pipe-C
[263.969023] Dynamic subtest pipe-C: SUCCESS (0.000s)
[263.977031] Starting dynamic subtest: pipe-D
[263.978955] Dynamic subtest pipe-D: SUCCESS (0.000s)
[263.980857] Subtest basic: SUCCESS (0.052s)
[264.042612] [058/133] (755s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[264.157605] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[264.162158] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[264.287418] [059/133] (755s left) kms_addfb_basic (bad-pitch-32)
[264.343860] Starting subtest: bad-pitch-32
[264.346272] Subtest bad-pitch-32: SUCCESS (0.000s)
[264.503032] [060/133] (755s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[264.569969] Starting subtest: x-tiled-to-vebox-y-tiled
[264.574355] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[264.763481] [061/133] (755s left) gem_exec_reloc (basic-range)
[264.829317] Subtest basic-range: SKIP (0.000s)
[264.899287] [062/133] (755s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[264.998918] Starting subtest: yf-tiled-64bpp-rotate-0
[265.003446] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[265.119573] [063/133] (754s left) syncobj_wait (wait-all-for-submit-snapshot)
[265.169451] Starting subtest: wait-all-for-submit-snapshot
[265.249561] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[265.352720] [064/133] (754s left) kms_async_flips (invalid-async-flip)
[265.446632] Starting subtest: invalid-async-flip
[265.820597] Starting dynamic subtest: pipe-A-eDP-1
[266.607140] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s)
[266.967280] Starting dynamic subtest: pipe-B-eDP-1
[267.742671] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.782s)
[268.096812] Starting dynamic subtest: pipe-C-eDP-1
[268.870228] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.780s)
[269.225952] Starting dynamic subtest: pipe-D-eDP-1
[269.997612] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s)
[269.999793] Subtest invalid-async-flip: SUCCESS (4.553s)
[271.154951] [065/133] (749s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[271.257234] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[271.259467] Starting dynamic subtest: A-eDP1
[274.874202] Dynamic subtest A-eDP1: SUCCESS (3.613s)
[274.883536] Starting dynamic subtest: B-eDP1
[278.052525] Dynamic subtest B-eDP1: SUCCESS (3.178s)
[278.064761] Starting dynamic subtest: C-eDP1
[281.224896] Dynamic subtest C-eDP1: SUCCESS (3.171s)
[281.233549] Starting dynamic subtest: D-eDP1
[284.338439] Dynamic subtest D-eDP1: SUCCESS (3.111s)
[284.340681] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.082s)
[285.144164] [066/133] (735s left) kms_frontbuffer_tracking (fbc-suspend)
[285.253329] Starting subtest: fbc-suspend
[323.557679] Subtest fbc-suspend: SUCCESS (7.569s)
[324.783733] [067/133] (695s left) syncobj_timeline (invalid-transfer-bad-pad)
[324.873111] Starting subtest: invalid-transfer-bad-pad
[324.876013] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[324.997948] [068/133] (695s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[325.099813] Starting subtest: 4-tiled-64bpp-rotate-90
[325.119622] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[325.295901] [069/133] (695s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[325.359385] Starting subtest: saturated-hostile-nopreempt
[325.362434] Starting dynamic subtest: rcs0
[325.460071] Dynamic subtest rcs0: SKIP (0.096s)
[325.472678] Starting dynamic subtest: bcs0
[325.486687] Dynamic subtest bcs0: SKIP (0.024s)
[325.496099] Starting dynamic subtest: vcs0
[325.512448] Dynamic subtest vcs0: SKIP (0.024s)
[325.521740] Starting dynamic subtest: vcs1
[325.537705] Dynamic subtest vcs1: SKIP (0.024s)
[325.546441] Starting dynamic subtest: vecs0
[325.563668] Dynamic subtest vecs0: SKIP (0.024s)
[325.572872] Starting dynamic subtest: ccs0
[325.587342] Dynamic subtest ccs0: SKIP (0.022s)
[325.592668] Subtest saturated-hostile-nopreempt: SKIP (0.224s)
[325.679383] [070/133] (694s left) gem_exec_big (single)
[325.740740] Starting subtest: single
[328.188840] Subtest single: SUCCESS (2.425s)
[328.417750] [071/133] (692s left) gem_exec_fence (submit67)
[328.658083] Starting subtest: submit67
[328.663622] Subtest submit67: SKIP (0.000s)
[330.708634] [072/133] (689s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[330.833794] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[330.838682] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[330.949839] [073/133] (689s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[331.054552] Starting subtest: fbc-rgb101010-draw-mmap-wc
[335.604987] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.537s)
[336.728591] [074/133] (683s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[336.833712] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[336.838546] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[336.965928] [075/133] (683s left) i915_drm_fdinfo (busy-idle)
[337.012662] Starting subtest: busy-idle
[337.015283] Starting dynamic subtest: rcs0
[337.049553] Dynamic subtest rcs0: SKIP (0.034s)
[337.059650] Starting dynamic subtest: bcs0
[337.063819] Dynamic subtest bcs0: SKIP (0.000s)
[337.073330] Starting dynamic subtest: vcs0
[337.077828] Dynamic subtest vcs0: SKIP (0.000s)
[337.086588] Starting dynamic subtest: vcs1
[337.090657] Dynamic subtest vcs1: SKIP (0.000s)
[337.099517] Starting dynamic subtest: vecs0
[337.103776] Dynamic subtest vecs0: SKIP (0.000s)
[337.112673] Starting dynamic subtest: ccs0
[337.117274] Dynamic subtest ccs0: SKIP (0.000s)
[337.121526] Subtest busy-idle: SKIP (0.040s)
[337.160122] [076/133] (683s left) kms_psr (psr2-primary-page-flip)
[337.258953] Starting subtest: psr2-primary-page-flip
[337.261130] Starting dynamic subtest: eDP-1
[339.008653] Dynamic subtest eDP-1: SUCCESS (1.743s)
[339.011642] Subtest psr2-primary-page-flip: SUCCESS (1.744s)
[339.894304] [077/133] (680s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[340.015790] Starting subtest: cursorA-vs-flipB-atomic
[340.020831] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[340.174500] [078/133] (680s left) kms_prop_blob (blob-prop-lifetime)
[340.238740] Starting subtest: blob-prop-lifetime
[340.241646] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[340.361204] [079/133] (680s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[340.461012] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[340.463637] Starting dynamic subtest: pipe-A
[340.582231] Dynamic subtest pipe-A: SKIP (0.118s)
[340.592065] Starting dynamic subtest: pipe-B
[341.749645] Dynamic subtest pipe-B: SKIP (1.164s)
[341.759716] Starting dynamic subtest: pipe-C
[342.889103] Dynamic subtest pipe-C: SUCCESS (1.143s)
[342.899314] Starting dynamic subtest: pipe-D
[344.034685] Dynamic subtest pipe-D: SUCCESS (1.143s)
[344.037613] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.572s)
[345.245610] [080/133] (675s left) kms_pipe_crc_basic (hang-read-crc)
[345.340573] Starting subtest: hang-read-crc
[345.343226] Starting dynamic subtest: pipe-A-eDP-1
[347.404981] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.059s)
[347.415362] Starting dynamic subtest: pipe-B-eDP-1
[350.077720] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.668s)
[350.088699] Starting dynamic subtest: pipe-C-eDP-1
[352.717569] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.636s)
[352.729705] Starting dynamic subtest: pipe-D-eDP-1
[355.358793] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.643s)
[355.361551] Subtest hang-read-crc: SUCCESS (10.013s)
[356.217592] [081/133] (664s left) kms_selftest (drm_format)
[356.276579] Starting subtest: drm_format
[356.286842] Starting dynamic subtest: drm_test_format_block_width_invalid
[356.400691] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.113s)
[356.410398] Starting dynamic subtest: drm_test_format_block_width_one_plane
[356.538378] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.137s)
[356.548694] Starting dynamic subtest: drm_test_format_block_width_two_plane
[356.667440] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.129s)
[356.678785] Starting dynamic subtest: drm_test_format_block_width_three_plane
[356.783573] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.114s)
[356.793807] Starting dynamic subtest: drm_test_format_block_width_tiled
[356.892297] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.110s)
[356.902037] Starting dynamic subtest: drm_test_format_block_height_invalid
[357.053306] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.159s)
[357.063534] Starting dynamic subtest: drm_test_format_block_height_one_plane
[357.213283] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.157s)
[357.223471] Starting dynamic subtest: drm_test_format_block_height_two_plane
[357.354918] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.142s)
[357.365070] Starting dynamic subtest: drm_test_format_block_height_three_plane
[357.492565] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.134s)
[357.503275] Starting dynamic subtest: drm_test_format_block_height_tiled
[357.629633] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.136s)
[357.639672] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[357.763513] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.132s)
[357.773321] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[357.885616] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.123s)
[357.895706] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[358.029663] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.142s)
[358.040674] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[358.140569] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.112s)
[358.150374] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[358.290821] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.147s)
[358.306353] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[358.435673] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.144s)
[358.446256] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[358.572647] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.136s)
[358.583977] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[358.721714] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.149s)
[358.724351] Subtest drm_format: SUCCESS (2.445s)
[358.936618] [082/133] (662s left) gem_close_race (multigpu-basic-process)
[359.001437] Starting subtest: multigpu-basic-process
[359.006818] Subtest multigpu-basic-process: SKIP (0.000s)
[359.247939] [083/133] (661s left) gem_set_tiling_vs_gtt
[359.374828] [084/133] (661s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[359.467693] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[359.470148] Starting dynamic subtest: pipe-A
[359.490840] Dynamic subtest pipe-A: SKIP (0.018s)
[359.500778] Starting dynamic subtest: pipe-B
[359.523550] Dynamic subtest pipe-B: SKIP (0.031s)
[359.533772] Starting dynamic subtest: pipe-C
[359.554493] Dynamic subtest pipe-C: SKIP (0.030s)
[359.564296] Starting dynamic subtest: pipe-D
[359.584340] Dynamic subtest pipe-D: SKIP (0.030s)
[359.589037] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.112s)
[359.711788] [085/133] (661s left) kms_addfb_basic (basic-y-tiled-legacy)
[359.774005] Starting subtest: basic-y-tiled-legacy
[359.778819] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[359.929475] [086/133] (661s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[360.042537] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[361.077510] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.034s)
[361.210012] [087/133] (659s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[361.271137] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[361.275719] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[361.459698] [088/133] (659s left) gem_caching (writes)
[361.524795] Subtest writes: SKIP (0.000s)
[361.610575] [089/133] (659s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[361.676995] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[361.779537] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[361.870971] [090/133] (659s left) kms_flip (wf_vblank-ts-check)
[361.964513] Starting subtest: wf_vblank-ts-check
[361.967062] Starting dynamic subtest: A-eDP1
[370.849353] Dynamic subtest A-eDP1: SUCCESS (8.883s)
[370.863121] Starting dynamic subtest: B-eDP1
[379.784356] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[379.795130] Starting dynamic subtest: C-eDP1
[388.706513] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[388.719461] Starting dynamic subtest: D-eDP1
[397.639793] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[397.642542] Subtest wf_vblank-ts-check: SUCCESS (35.668s)
[398.879267] [091/133] (622s left) gem_lmem_evict (dontneed-evict-race)
[398.933651] Subtest dontneed-evict-race: SKIP (0.000s)
[398.984030] [092/133] (622s left) gem_mmap_gtt (medium-copy-odd)
[399.040615] Subtest medium-copy-odd: SKIP (0.000s)
[399.113536] [093/133] (622s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[399.207150] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[399.222118] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[399.292637] [094/133] (622s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[399.393529] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[399.396226] Starting dynamic subtest: pipe-A-eDP-1
[399.473086] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[399.483666] Starting dynamic subtest: pipe-B-eDP-1
[399.550667] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[399.560840] Starting dynamic subtest: pipe-C-eDP-1
[399.619685] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[399.628776] Starting dynamic subtest: pipe-D-eDP-1
[399.693810] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[399.698892] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[401.551937] [095/133] (619s left) gem_exec_suspend (basic-s0)
[401.627864] Starting subtest: basic-S0
[401.630880] Starting dynamic subtest: smem
[421.934512] Dynamic subtest smem: SUCCESS (6.904s)
[421.937571] Subtest basic-S0: SUCCESS (6.907s)
[422.151245] [096/133] (599s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[422.262106] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[423.255091] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.980s)
[423.414623] [097/133] (598s left) gem_mmap_offset (bad-extensions)
[423.473144] Starting subtest: bad-extensions
[423.475956] Subtest bad-extensions: SUCCESS (0.000s)
[423.570592] [098/133] (598s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[423.689062] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[423.693844] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[423.859865] [099/133] (597s left) gem_mmap_gtt (cpuset-big-copy-odd)
[423.919253] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[423.987808] [100/133] (597s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[424.107085] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[424.112026] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[424.241737] [101/133] (597s left) kms_psr (fbc-psr2-sprite-render)
[424.328229] Starting subtest: fbc-psr2-sprite-render
[424.330688] Starting dynamic subtest: eDP-1
[424.334992] Dynamic subtest eDP-1: SKIP (0.000s)
[424.339431] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[424.417532] [102/133] (597s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[424.518737] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[424.522246] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[424.621427] [103/133] (597s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[424.715409] Starting subtest: crc-primary-basic-y-tiled-ccs
[424.717415] Starting dynamic subtest: pipe-A-eDP-1
[424.738410] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[424.750710] Starting dynamic subtest: pipe-B-eDP-1
[424.772056] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[424.780953] Starting dynamic subtest: pipe-C-eDP-1
[424.802583] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[424.811477] Starting dynamic subtest: pipe-D-eDP-1
[424.834440] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[424.839006] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[427.068090] [104/133] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[427.173371] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[427.179100] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[427.303641] [105/133] (594s left) api_intel_bb (add-remove-objects)
[427.370860] Starting subtest: add-remove-objects
[427.375744] Subtest add-remove-objects: SUCCESS (0.008s)
[427.518259] [106/133] (594s left) sysfs_heartbeat_interval (nopreempt)
[427.582805] Starting subtest: nopreempt
[427.585350] Starting dynamic subtest: vecs0
[436.992473] Dynamic subtest vecs0: SUCCESS (9.364s)
[437.005206] Starting dynamic subtest: ccs0
[441.061215] Dynamic subtest ccs0: SUCCESS (4.061s)
[441.073900] Starting dynamic subtest: vcs0
[451.016961] Dynamic subtest vcs0: SUCCESS (9.940s)
[451.029749] Starting dynamic subtest: bcs0
[455.004580] Dynamic subtest bcs0: SUCCESS (3.987s)
[455.017003] Starting dynamic subtest: rcs0
[459.052723] Dynamic subtest rcs0: SUCCESS (4.047s)
[459.065120] Starting dynamic subtest: vcs1
[469.001126] Dynamic subtest vcs1: SUCCESS (9.945s)
[469.004131] Subtest nopreempt: SUCCESS (41.355s)
[469.099832] [107/133] (552s left) kms_getfb (getfb2-into-addfb2)
[469.208066] Starting subtest: getfb2-into-addfb2
[469.210980] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[469.340701] [108/133] (552s left) gem_close (basic)
[469.404455] Starting subtest: basic
[469.407052] Subtest basic: SUCCESS (0.000s)
[469.548298] [109/133] (552s left) gem_exec_schedule (preemptive-hang)
[469.734087] Starting subtest: preemptive-hang
[469.737097] Starting dynamic subtest: rcs0
[479.069251] Dynamic subtest rcs0: SUCCESS (9.332s)
[479.080544] Starting dynamic subtest: bcs0
[488.091242] Dynamic subtest bcs0: SUCCESS (9.019s)
[488.103695] Starting dynamic subtest: vcs0
[497.111296] Dynamic subtest vcs0: SUCCESS (9.015s)
[497.121193] Starting dynamic subtest: vcs1
[506.074259] Dynamic subtest vcs1: SUCCESS (8.956s)
[506.084022] Starting dynamic subtest: vecs0
[515.090381] Dynamic subtest vecs0: SUCCESS (9.010s)
[515.103234] Starting dynamic subtest: ccs0
[524.058928] Dynamic subtest ccs0: SUCCESS (8.970s)
[524.061853] Subtest preemptive-hang: SUCCESS (54.314s)
[524.318321] [110/133] (497s left) i915_drm_fdinfo (virtual-busy-idle)
[524.363687] Starting subtest: virtual-busy-idle
[524.369014] Subtest virtual-busy-idle: SKIP (0.000s)
[524.452335] [111/133] (497s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[524.566334] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[528.528005] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.969s)
[529.755820] [112/133] (492s left) gem_linear_blits (interruptible)
[529.975621] Starting subtest: interruptible
[534.469500] Subtest interruptible: SUCCESS (4.494s)
[534.640040] [113/133] (487s left) gem_ctx_persistence (engines-mixed)
[534.755734] Starting subtest: engines-mixed
[534.758760] Starting dynamic subtest: rcs0
[534.877181] Dynamic subtest rcs0: SUCCESS (0.121s)
[534.893462] Starting dynamic subtest: bcs0
[534.959356] Dynamic subtest bcs0: SUCCESS (0.079s)
[534.973002] Starting dynamic subtest: vcs0
[535.042421] Dynamic subtest vcs0: SUCCESS (0.081s)
[535.057875] Starting dynamic subtest: vcs1
[535.124365] Dynamic subtest vcs1: SUCCESS (0.080s)
[535.136048] Starting dynamic subtest: vecs0
[535.210145] Dynamic subtest vecs0: SUCCESS (0.084s)
[535.223572] Starting dynamic subtest: ccs0
[535.292244] Dynamic subtest ccs0: SUCCESS (0.080s)
[535.295199] Subtest engines-mixed: SUCCESS (0.537s)
[535.396863] [114/133] (486s left) perf_pmu (init-wait)
[535.447970] Starting subtest: init-wait
[535.450983] Starting dynamic subtest: rcs0
[535.453784] Dynamic subtest rcs0: SUCCESS (0.002s)
[535.470486] Starting dynamic subtest: bcs0
[535.473197] Dynamic subtest bcs0: SUCCESS (0.001s)
[535.483207] Starting dynamic subtest: vcs0
[535.485669] Dynamic subtest vcs0: SUCCESS (0.001s)
[535.495065] Starting dynamic subtest: vcs1
[535.497231] Dynamic subtest vcs1: SUCCESS (0.001s)
[535.507100] Starting dynamic subtest: vecs0
[535.509621] Dynamic subtest vecs0: SUCCESS (0.001s)
[535.519099] Starting dynamic subtest: ccs0
[535.521598] Dynamic subtest ccs0: SUCCESS (0.001s)
[535.523895] Subtest init-wait: SUCCESS (0.009s)
[535.597862] [115/133] (486s left) gem_exec_reloc (basic-gtt-cpu-active)
[535.657080] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[535.743418] [116/133] (486s left) kms_pm_lpsp (screens-disabled)
[536.853212] Starting subtest: screens-disabled
[536.858213] Subtest screens-disabled: SKIP (0.000s)
[536.936035] [117/133] (485s left) kms_flip (flip-vs-expired-vblank-interruptible)
[537.041860] Starting subtest: flip-vs-expired-vblank-interruptible
[537.044619] Starting dynamic subtest: A-eDP1
[545.738122] Dynamic subtest A-eDP1: SUCCESS (8.697s)
[545.749714] Starting dynamic subtest: B-eDP1
[554.363523] Dynamic subtest B-eDP1: SUCCESS (8.624s)
[554.377242] Starting dynamic subtest: C-eDP1
[562.988212] Dynamic subtest C-eDP1: SUCCESS (8.623s)
[563.002959] Starting dynamic subtest: D-eDP1
[571.626158] Dynamic subtest D-eDP1: SUCCESS (8.635s)
[571.632214] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.588s)
[572.806812] [118/133] (449s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[572.910025] Starting subtest: psr-1p-primscrn-cur-indfb-move
[580.266188] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.360s)
[580.431554] [119/133] (442s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[580.531119] Starting subtest: plane-all-modeset-transition-internal-panels
[580.534064] Starting dynamic subtest: pipe-A-eDP-1
[581.877202] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.344s)
[582.155019] Starting dynamic subtest: pipe-B-eDP-1
[583.199209] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.052s)
[583.468223] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.936s)
[584.341824] [120/133] (438s left) gem_userptr_blits (stress-mm)
[584.411642] Starting subtest: stress-mm
[589.782701] Subtest stress-mm: SUCCESS (5.369s)
[589.932551] [121/133] (432s left) syncobj_eventfd (invalid-bad-flags)
[589.988916] Starting subtest: invalid-bad-flags
[589.991798] Subtest invalid-bad-flags: SUCCESS (0.000s)
[590.116067] [122/133] (432s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[590.179413] Starting subtest: framebuffer-vs-set-tiling
[590.184172] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[590.346808] [123/133] (432s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[590.448309] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[590.453419] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[590.571993] [124/133] (432s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[590.638202] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[590.641009] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[590.744200] [125/133] (432s left) kms_flip (2x-modeset-vs-vblank-race)
[590.837206] Starting subtest: 2x-modeset-vs-vblank-race
[590.846390] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[590.977123] [126/133] (431s left) i915_query (query-regions-garbage-items)
[591.040146] Starting subtest: query-regions-garbage-items
[591.042729] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[591.167485] [127/133] (431s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[591.276571] Starting subtest: flip-primary-invalidate-overlay
[603.015775] Subtest flip-primary-invalidate-overlay: SUCCESS (11.738s)
[603.202015] [128/133] (419s left) gem_exec_balancer (full-late)
[603.269514] Starting subtest: full-late
[607.797225] Subtest full-late: SUCCESS (4.526s)
[608.147441] [129/133] (414s left) gem_exec_reloc (basic-write-wc)
[608.219923] Subtest basic-write-wc: SKIP (0.000s)
[608.297076] [130/133] (414s left) kms_force_connector_basic (force-load-detect)
[608.374244] Starting subtest: force-load-detect
[608.378746] Subtest force-load-detect: SKIP (0.000s)
[608.504512] [131/133] (414s left) kms_chamelium_hpd (hdmi-hpd-fast)
[608.897718] Subtest hdmi-hpd-fast: SKIP (0.000s)
[609.739879] [132/133] (413s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[609.832559] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[609.834855] Starting dynamic subtest: pipe-A-default-mode
[612.674128] Dynamic subtest pipe-A-default-mode: SUCCESS (2.839s)
[612.677017] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.840s)
[613.510031] [133/133] (409s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[613.606368] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[613.611179] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[613.739002] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: core_getversion
results: parsing output: 2/ for test: kms_atomic_interruptible
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: kms_color
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: gem_ccs
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: core_getstats
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: i915_pm_rps
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_dp_link_training
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_parallel
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: prime_mmap
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: prime_busy
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: gem_wait
results: parsing output: 44/ for test: gen9_exec_parse
results: parsing output: 45/ for test: kms_cursor_edge_walk
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_chamelium_audio
results: parsing output: 50/ for test: kms_chamelium_edid
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_joiner
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_legacy_colorkey
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: gem_exec_big
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: i915_drm_fdinfo
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_prop_blob
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_pipe_crc_basic
results: parsing output: 80/ for test: kms_selftest
results: parsing output: 81/ for test: gem_close_race
results: parsing output: 82/ for test: gem_set_tiling_vs_gtt
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_caching
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_lmem_evict
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_exec_suspend
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: api_intel_bb
results: parsing output: 105/ for test: sysfs_heartbeat_interval
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_close
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_linear_blits
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_pm_lpsp
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_atomic_transition
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: kms_psr_stress_test
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_force_connector_basic
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.