[57.484901] Initializing watchdogs
[57.484949]   /dev/watchdog0
[57.502033] [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.506558] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.508845] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.512275] [001/155] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[57.642961] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[57.647422] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[57.721608] [002/155] (960s left) kms_addfb_basic (invalid-set-prop-any)
[57.771944] Starting subtest: invalid-set-prop-any
[57.774351] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[57.910950] [003/155] (960s left) gem_wait (await)
[57.997860] Starting subtest: await
[58.000224] Starting dynamic subtest: all-engines
[59.126962] Dynamic subtest all-engines: SUCCESS (1.145s)
[59.143446] Starting dynamic subtest: rcs0
[60.183155] Dynamic subtest rcs0: SUCCESS (1.067s)
[60.198879] Starting dynamic subtest: bcs0
[61.239977] Dynamic subtest bcs0: SUCCESS (1.066s)
[61.257763] Starting dynamic subtest: vcs0
[62.297221] Dynamic subtest vcs0: SUCCESS (1.065s)
[62.311157] Starting dynamic subtest: vcs1
[63.351199] Dynamic subtest vcs1: SUCCESS (1.060s)
[63.367897] Starting dynamic subtest: vecs0
[64.406948] Dynamic subtest vecs0: SUCCESS (1.061s)
[64.421734] Starting dynamic subtest: ccs0
[65.463926] Dynamic subtest ccs0: SUCCESS (1.062s)
[65.466401] Subtest await: SUCCESS (7.531s)
[65.686169] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[65.689186] [004/155] (952s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[65.794255] Starting subtest: psr-indfb-scaledprimary
[71.548047] Subtest psr-indfb-scaledprimary: SUCCESS (5.778s)
[71.671079] [005/155] (946s left) kms_async_flips (crc-atomic)
[71.761186] Starting subtest: crc-atomic
[72.149786] Starting dynamic subtest: pipe-A-eDP-1
[75.050653] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.904s)
[75.429788] Starting dynamic subtest: pipe-B-eDP-1
[78.364879] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.946s)
[78.754389] Starting dynamic subtest: pipe-C-eDP-1
[81.673895] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.936s)
[82.040896] Starting dynamic subtest: pipe-D-eDP-1
[84.903610] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.875s)
[84.905888] Subtest crc-atomic: SUCCESS (13.158s)
[86.088430] [006/155] (932s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[86.195431] Starting subtest: yf-tiled-8bpp-rotate-270
[86.199802] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[86.298923] [007/155] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[86.400745] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[86.405261] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[86.496686] [008/155] (931s left) kms_pm_rpm (modeset-lpsp-stress)
[88.457614] Starting subtest: modeset-lpsp-stress
[104.138718] Subtest modeset-lpsp-stress: SUCCESS (15.678s)
[104.259827] [009/155] (914s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[104.356695] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[104.361194] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[104.451166] [010/155] (913s left) drm_read (short-buffer-nonblock)
[104.586494] Starting subtest: short-buffer-nonblock
[104.588723] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[104.699218] [011/155] (913s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[104.787866] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[104.800368] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[104.901659] [012/155] (913s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[105.004989] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[105.009357] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[105.102978] [013/155] (913s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[105.232303] Starting subtest: cursorA-vs-flipB-legacy
[105.236202] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[105.384653] [014/155] (913s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[105.450050] Starting subtest: y-tiled-to-vebox-y-tiled
[105.453859] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[105.647576] [015/155] (912s left) kms_psr (pr-primary-render)
[105.735237] Starting subtest: pr-primary-render
[105.739368] Subtest pr-primary-render: SKIP (0.000s)
[105.805709] [016/155] (912s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[105.900982] Starting subtest: x-tiled-32bpp-rotate-180
[107.390705] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.490s)
[107.524905] [017/155] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[107.626810] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[107.630450] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[107.727542] [018/155] (910s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[107.816546] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[107.820231] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[107.888158] [019/155] (910s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[107.986436] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[107.990227] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[108.099465] [020/155] (910s left) gem_ctx_param (non-root-set)
[108.161687] Starting subtest: non-root-set
[108.185195] Subtest non-root-set: SUCCESS (0.024s)
[108.283373] [021/155] (910s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[108.364174] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[108.365952] Starting dynamic subtest: pipe-A-eDP-1
[108.413151] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[108.421738] Starting dynamic subtest: pipe-B-eDP-1
[108.467489] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[108.475943] Starting dynamic subtest: pipe-C-eDP-1
[108.522881] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[108.531973] Starting dynamic subtest: pipe-D-eDP-1
[108.579108] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[108.582624] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[110.660745] [022/155] (908s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[110.758925] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[110.761271] Starting dynamic subtest: pipe-A-default-mode
[113.500623] Dynamic subtest pipe-A-default-mode: SUCCESS (2.740s)
[113.502973] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.741s)
[114.363778] [023/155] (904s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[114.469702] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[114.474108] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[114.574218] [024/155] (904s left) kms_prop_blob (basic)
[114.634311] Starting subtest: basic
[114.636715] Subtest basic: SUCCESS (0.000s)
[114.743418] [025/155] (904s left) kms_hdr (static-toggle-dpms)
[114.836181] Starting subtest: static-toggle-dpms
[114.838486] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[114.842889] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[114.851352] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[114.855460] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[114.859575] Subtest static-toggle-dpms: SKIP (0.002s)
[114.907354] [026/155] (904s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[115.019080] Starting subtest: basic-flip-before-cursor-varying-size
[115.949030] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.928s)
[116.796648] [027/155] (902s left) kms_addfb_basic (bad-pitch-63)
[116.847029] Starting subtest: bad-pitch-63
[116.849189] Subtest bad-pitch-63: SUCCESS (0.000s)
[116.980467] [028/155] (902s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[117.075567] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[123.687275] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.616s)
[123.816186] [029/155] (895s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[123.911968] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[130.961110] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.055s)
[131.083586] [030/155] (888s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[131.182862] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[135.161413] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.984s)
[136.331369] [031/155] (882s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[136.430565] Starting subtest: fbc-rgb565-draw-blt
[140.623885] Subtest fbc-rgb565-draw-blt: SUCCESS (4.200s)
[141.826548] [032/155] (877s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[141.931841] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[141.935985] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[142.047136] [033/155] (877s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[142.153879] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[142.157972] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[142.244305] [034/155] (877s left) prime_mmap (test_errors)
[142.305786] Starting subtest: test_errors
[142.307690] Starting dynamic subtest: test_errors-smem
[142.404940] Dynamic subtest test_errors-smem: SUCCESS (0.100s)
[142.407767] Subtest test_errors: SUCCESS (0.101s)
[142.501038] [035/155] (876s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[142.595796] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[142.599802] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[142.685745] [036/155] (876s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[142.794298] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[142.797812] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[142.874084] [037/155] (876s left) gem_render_copy (linear)
[142.923870] Starting subtest: linear
[142.925970] Starting dynamic subtest: smem
[142.965850] Dynamic subtest smem: SUCCESS (0.041s)
[142.968399] Subtest linear: SUCCESS (0.042s)
[143.211938] [038/155] (876s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[143.307698] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[143.311951] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[143.413867] [039/155] (876s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[143.512176] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[143.516638] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[143.612486] [040/155] (876s left) kms_cursor_crc (cursor-sliding-256x85)
[143.857787] Starting subtest: cursor-sliding-256x85
[143.904203] Subtest cursor-sliding-256x85: SKIP (0.043s)
[144.053625] [041/155] (875s left) dmabuf_sync_file (export-basic)
[144.095569] Starting subtest: export-basic
[144.097488] Subtest export-basic: SUCCESS (0.001s)
[144.155577] [042/155] (875s left) syncobj_wait (reset-unsignaled)
[144.203685] Starting subtest: reset-unsignaled
[144.205840] Subtest reset-unsignaled: SUCCESS (0.000s)
[144.306920] [043/155] (875s left) kms_chamelium_edid (hdmi-mode-timings)
[144.682635] Subtest hdmi-mode-timings: SKIP (0.000s)
[145.533514] [044/155] (874s left) syncobj_timeline (wait-all-interrupted)
[145.586704] Starting subtest: wait-all-interrupted
[145.694525] Subtest wait-all-interrupted: SUCCESS (0.106s)
[145.769809] [045/155] (874s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[145.996735] Starting subtest: cursor-rapid-movement-128x42
[146.046056] Subtest cursor-rapid-movement-128x42: SKIP (0.042s)
[146.247983] [046/155] (873s left) gem_close_race (multigpu-basic-threads)
[146.302931] Starting subtest: multigpu-basic-threads
[146.307475] Subtest multigpu-basic-threads: SKIP (0.000s)
[146.525430] [047/155] (873s left) gem_exec_capture (capture-recoverable)
[146.577364] Starting subtest: capture-recoverable
[146.579734] Subtest capture-recoverable: SUCCESS (0.004s)
[146.690136] [048/155] (873s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[146.786049] Starting subtest: y-tiled-32bpp-rotate-180
[146.790605] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[146.877535] [049/155] (873s left) kms_flip (flip-vs-modeset-vs-hang)
[146.959805] Starting subtest: flip-vs-modeset-vs-hang
[146.962121] Starting dynamic subtest: A-eDP1
[197.797770] Dynamic subtest A-eDP1: SUCCESS (50.835s)
[197.807066] Starting dynamic subtest: D-eDP1
[247.780462] Dynamic subtest D-eDP1: SUCCESS (49.978s)
[247.782643] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.820s)
[248.169974] [050/155] (771s left) gem_mmap_wc (write-read-distinct)
[248.229651] Subtest write-read-distinct: SKIP (0.000s)
[248.301555] [051/155] (771s left) gem_mmap_gtt (basic-small-copy-xy)
[248.354703] Subtest basic-small-copy-XY: SKIP (0.000s)
[248.407633] [052/155] (771s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[248.506020] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[248.508453] Starting dynamic subtest: pipe-A-eDP-1
[264.960942] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.458s)
[264.970844] Starting dynamic subtest: pipe-B-eDP-1
[282.168310] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.204s)
[282.170828] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.665s)
[283.037357] [053/155] (737s left) gem_ctx_param (invalid-get-engines)
[283.088281] Starting subtest: invalid-get-engines
[283.090556] Subtest invalid-get-engines: SUCCESS (0.001s)
[283.196460] [054/155] (737s left) perf_pmu (busy-accuracy-50)
[283.235470] Starting subtest: busy-accuracy-50
[283.237812] Starting dynamic subtest: rcs0
[284.768709] Dynamic subtest rcs0: SUCCESS (1.530s)
[284.778435] Starting dynamic subtest: bcs0
[286.309387] Dynamic subtest bcs0: SUCCESS (1.538s)
[286.320559] Starting dynamic subtest: vcs0
[287.852903] Dynamic subtest vcs0: SUCCESS (1.541s)
[287.864721] Starting dynamic subtest: vcs1
[289.399218] Dynamic subtest vcs1: SUCCESS (1.544s)
[289.409341] Starting dynamic subtest: vecs0
[290.940283] Dynamic subtest vecs0: SUCCESS (1.538s)
[290.950335] Starting dynamic subtest: ccs0
[292.488758] Dynamic subtest ccs0: SUCCESS (1.546s)
[292.491463] Subtest busy-accuracy-50: SUCCESS (9.252s)
[292.605926] [055/155] (727s left) gen9_exec_parse (allowed-all)
[292.674122] Subtest allowed-all: SKIP (0.000s)
[292.754395] [056/155] (727s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen)
[292.862666] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen
[292.866876] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[292.970294] [057/155] (727s left) gem_exec_whisper (basic-contexts-forked-all)
[293.036682] Starting subtest: basic-contexts-forked-all
[313.097809] Subtest basic-contexts-forked-all: SUCCESS (20.057s)
[313.297124] [058/155] (707s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[313.411250] Starting subtest: psr-2p-pri-indfb-multidraw
[313.415997] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[313.497719] [059/155] (706s left) kms_color (legacy-gamma-reset)
[313.596076] Starting subtest: legacy-gamma-reset
[313.597925] Starting dynamic subtest: pipe-A-eDP-1
[313.969587] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.375s)
[313.979706] Starting dynamic subtest: pipe-B-eDP-1
[313.982117] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[313.991489] Starting dynamic subtest: pipe-C-eDP-1
[313.993423] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[314.002488] Starting dynamic subtest: pipe-D-eDP-1
[314.007492] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[314.009909] Subtest legacy-gamma-reset: SUCCESS (0.412s)
[314.754933] [060/155] (705s left) gem_eio (create-ext)
[314.967283] Starting subtest: create-ext
[315.282132] Subtest create-ext: SUCCESS (0.313s)
[315.425696] [061/155] (705s left) i915_drm_fdinfo (isolation)
[315.470795] Starting subtest: isolation
[315.473047] Starting dynamic subtest: rcs0
[315.505147] Dynamic subtest rcs0: SKIP (0.032s)
[315.516707] Starting dynamic subtest: bcs0
[315.520708] Dynamic subtest bcs0: SKIP (0.000s)
[315.530595] Starting dynamic subtest: vcs0
[315.534855] Dynamic subtest vcs0: SKIP (0.000s)
[315.544108] Starting dynamic subtest: vcs1
[315.548060] Dynamic subtest vcs1: SKIP (0.000s)
[315.556881] Starting dynamic subtest: vecs0
[315.561095] Dynamic subtest vecs0: SKIP (0.001s)
[315.570031] Starting dynamic subtest: ccs0
[315.574401] Dynamic subtest ccs0: SKIP (0.001s)
[315.578666] Subtest isolation: SKIP (0.041s)
[315.618912] [062/155] (704s left) gem_exec_fence (invalid-timeline-fence-array)
[316.211088] Starting subtest: invalid-timeline-fence-array
[316.217811] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[317.404679] [063/155] (703s left) i915_hangman (engine-engine-error)
[317.460460] Starting subtest: engine-engine-error
[317.462633] Starting dynamic subtest: rcs0
[319.275450] Dynamic subtest rcs0: SUCCESS (1.814s)
[319.287535] Starting dynamic subtest: bcs0
[321.259418] Dynamic subtest bcs0: SUCCESS (1.981s)
[321.271478] Starting dynamic subtest: vcs0
[323.304491] Dynamic subtest vcs0: SUCCESS (2.043s)
[323.317944] Starting dynamic subtest: vcs1
[325.287511] Dynamic subtest vcs1: SUCCESS (1.980s)
[325.300993] Starting dynamic subtest: vecs0
[327.272463] Dynamic subtest vecs0: SUCCESS (1.982s)
[327.287095] Starting dynamic subtest: ccs0
[329.256482] Dynamic subtest ccs0: SUCCESS (1.981s)
[329.259462] Subtest engine-engine-error: SUCCESS (11.797s)
[329.385264] [064/155] (691s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[329.494360] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[329.498570] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[329.594980] [065/155] (691s left) kms_vblank (wait-idle)
[329.688072] Starting subtest: wait-idle
[329.690095] Starting dynamic subtest: pipe-A-eDP-1
[331.440498] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[331.456869] Starting dynamic subtest: pipe-D-eDP-1
[333.899485] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.459s)
[333.901992] Subtest wait-idle: SUCCESS (4.215s)
[334.731623] [066/155] (685s left) kms_pipe_crc_basic (bad-source)
[334.829161] Starting subtest: bad-source
[334.830999] Subtest bad-source: SUCCESS (0.000s)
[334.901617] [067/155] (685s left) prime_vgem (fence-wait)
[334.962810] Starting subtest: fence-wait
[334.965204] Starting dynamic subtest: rcs0
[336.006240] Dynamic subtest rcs0: SUCCESS (1.042s)
[336.016755] Starting dynamic subtest: bcs0
[337.064339] Dynamic subtest bcs0: SUCCESS (1.057s)
[337.074533] Starting dynamic subtest: vcs0
[338.105245] Dynamic subtest vcs0: SUCCESS (1.038s)
[338.118178] Starting dynamic subtest: vcs1
[339.148643] Dynamic subtest vcs1: SUCCESS (1.041s)
[339.161603] Starting dynamic subtest: vecs0
[340.191208] Dynamic subtest vecs0: SUCCESS (1.040s)
[340.203793] Starting dynamic subtest: ccs0
[341.235619] Dynamic subtest ccs0: SUCCESS (1.042s)
[341.238773] Subtest fence-wait: SUCCESS (6.273s)
[341.377112] [068/155] (679s left) gem_exec_schedule (implicit-read-write)
[341.451736] Starting subtest: implicit-read-write
[341.453684] Starting dynamic subtest: rcs0
[341.629651] Dynamic subtest rcs0: SUCCESS (0.184s)
[341.640075] Starting dynamic subtest: vcs0
[341.734901] Dynamic subtest vcs0: SUCCESS (0.106s)
[341.746532] Starting dynamic subtest: vcs1
[341.845079] Dynamic subtest vcs1: SUCCESS (0.109s)
[341.856752] Starting dynamic subtest: vecs0
[341.951893] Dynamic subtest vecs0: SUCCESS (0.106s)
[341.964197] Starting dynamic subtest: ccs0
[342.086779] Dynamic subtest ccs0: SUCCESS (0.135s)
[342.089261] Subtest implicit-read-write: SUCCESS (0.644s)
[343.410706] [069/155] (677s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[343.519581] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite
[343.523640] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[343.631662] [070/155] (677s left) syncobj_wait (single-wait-for-submit-submitted)
[343.689811] Starting subtest: single-wait-for-submit-submitted
[343.797841] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[343.888894] [071/155] (677s left) kms_psr (fbc-psr-cursor-render)
[343.992105] Starting subtest: fbc-psr-cursor-render
[343.994452] Starting dynamic subtest: eDP-1
[343.998652] Dynamic subtest eDP-1: SKIP (0.000s)
[344.002834] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[344.078561] [072/155] (676s left) syncobj_timeline (invalid-signal-illegal-point)
[344.139103] Starting subtest: invalid-signal-illegal-point
[344.141437] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[344.245944] [073/155] (676s left) gem_mmap_gtt (cpuset-big-copy-xy)
[344.302198] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[344.372473] [074/155] (676s left) gem_exec_schedule (noreorder-corked)
[344.556645] Starting subtest: noreorder-corked
[344.558625] Starting dynamic subtest: rcs0
[345.700052] Dynamic subtest rcs0: SUCCESS (1.146s)
[345.712540] Starting dynamic subtest: vcs0
[347.331265] Dynamic subtest vcs0: SUCCESS (1.628s)
[347.341811] Starting dynamic subtest: vcs1
[349.328826] Dynamic subtest vcs1: SUCCESS (1.995s)
[349.341690] Starting dynamic subtest: vecs0
[351.299506] Dynamic subtest vecs0: SUCCESS (1.967s)
[351.313221] Starting dynamic subtest: ccs0
[352.456076] Dynamic subtest ccs0: SUCCESS (1.155s)
[352.458703] Subtest noreorder-corked: SUCCESS (7.903s)
[352.643277] [075/155] (668s left) kms_psr (psr-primary-mmap-cpu)
[352.739013] Starting subtest: psr-primary-mmap-cpu
[352.741327] Starting dynamic subtest: eDP-1
[354.513270] Dynamic subtest eDP-1: SUCCESS (1.772s)
[354.515509] Subtest psr-primary-mmap-cpu: SUCCESS (1.774s)
[355.399527] [076/155] (665s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[355.501958] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[355.506193] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[355.604455] [077/155] (665s left) kms_force_connector_basic (force-load-detect)
[355.690929] Starting subtest: force-load-detect
[355.695428] Subtest force-load-detect: SKIP (0.000s)
[355.805800] [078/155] (665s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[355.900983] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-pwrite
[355.905434] Subtest psrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[356.008691] [079/155] (665s left) kms_flip (blocking-absolute-wf_vblank)
[356.101265] Starting subtest: blocking-absolute-wf_vblank
[356.103663] Starting dynamic subtest: A-eDP1
[364.840854] Dynamic subtest A-eDP1: SUCCESS (8.738s)
[364.855294] Starting dynamic subtest: B-eDP1
[373.574190] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[373.589721] Starting dynamic subtest: C-eDP1
[382.290497] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[382.303313] Starting dynamic subtest: D-eDP1
[391.029637] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[391.032061] Subtest blocking-absolute-wf_vblank: SUCCESS (34.929s)
[392.241566] [080/155] (629s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[392.341885] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[393.010601] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.670s)
[393.176339] [081/155] (628s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[393.273241] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[394.108996] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[394.294464] [082/155] (627s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[394.394560] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[394.398757] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[394.485703] [083/155] (626s left) gem_pxp (create-valid-protected-context)
[394.603858] Starting subtest: create-valid-protected-context
[394.606943] Subtest create-valid-protected-context: SUCCESS (0.002s)
[394.721048] [084/155] (626s left) i915_pm_rpm (system-suspend-execbuf)
[396.457572] Starting subtest: system-suspend-execbuf
[454.970685] Subtest system-suspend-execbuf: SUCCESS (43.274s)
[455.362278] [085/155] (566s left) kms_rmfb (close-fd)
[455.454404] Starting subtest: close-fd
[455.456237] Starting dynamic subtest: pipe-A-eDP-1
[455.562961] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[455.574343] Starting dynamic subtest: pipe-B-eDP-1
[456.713493] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.151s)
[456.726373] Starting dynamic subtest: pipe-C-eDP-1
[457.936283] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.223s)
[457.947124] Starting dynamic subtest: pipe-D-eDP-1
[459.170549] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[459.172412] Subtest close-fd: SUCCESS (3.718s)
[460.371648] [086/155] (561s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[460.467288] Starting subtest: fbc-pr-sprite-mmap-gtt
[460.471703] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[460.542726] [087/155] (561s left) syncobj_basic (bad-destroy)
[460.597803] Starting subtest: bad-destroy
[460.600054] Subtest bad-destroy: SUCCESS (0.000s)
[460.714466] [088/155] (560s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[460.812819] Starting subtest: nonblocking-crc-frame-sequence
[460.814739] Starting dynamic subtest: pipe-A-eDP-1
[461.572019] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.758s)
[461.583456] Starting dynamic subtest: pipe-B-eDP-1
[462.979962] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s)
[462.990535] Starting dynamic subtest: pipe-C-eDP-1
[464.359984] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[464.371011] Starting dynamic subtest: pipe-D-eDP-1
[465.702918] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[465.705311] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.893s)
[466.512051] [089/155] (555s left) kms_flip (2x-flip-vs-dpms-on-nop)
[466.615620] Starting subtest: 2x-flip-vs-dpms-on-nop
[466.627471] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[466.710003] [090/155] (555s left) kms_frontbuffer_tracking (fbc-suspend)
[466.813197] Starting subtest: fbc-suspend
[505.552374] Subtest fbc-suspend: SUCCESS (7.643s)
[506.735116] [091/155] (515s left) gem_spin_batch (legacy-resubmit)
[506.817532] Starting subtest: legacy-resubmit
[506.819638] Starting dynamic subtest: default
[506.824041] Dynamic subtest default: SUCCESS (0.007s)
[506.835811] Starting dynamic subtest: render
[506.837916] Dynamic subtest render: SUCCESS (0.001s)
[506.848130] Starting dynamic subtest: bsd
[506.850208] Dynamic subtest bsd: SUCCESS (0.003s)
[506.859823] Starting dynamic subtest: bsd1
[506.861948] Dynamic subtest bsd1: SUCCESS (0.001s)
[506.872067] Starting dynamic subtest: bsd2
[506.874247] Dynamic subtest bsd2: SUCCESS (0.003s)
[506.884419] Starting dynamic subtest: blt
[506.886630] Dynamic subtest blt: SUCCESS (0.003s)
[506.896240] Starting dynamic subtest: vebox
[506.898431] Dynamic subtest vebox: SUCCESS (0.003s)
[506.900661] Subtest legacy-resubmit: SUCCESS (0.025s)
[507.052317] [092/155] (514s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[507.159163] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[507.163398] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[507.251201] [093/155] (514s left) kms_psr (psr-sprite-render)
[507.337633] Starting subtest: psr-sprite-render
[507.339850] Starting dynamic subtest: eDP-1
[509.033974] Dynamic subtest eDP-1: SUCCESS (1.718s)
[509.036300] Subtest psr-sprite-render: SUCCESS (1.719s)
[509.897783] [094/155] (511s left) kms_cursor_crc (cursor-dpms)
[510.037108] Starting subtest: cursor-dpms
[510.039335] Starting dynamic subtest: pipe-A-eDP-1
[513.041082] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.026s)
[513.052453] Starting dynamic subtest: pipe-D-eDP-1
[516.709447] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.686s)
[516.711999] Subtest cursor-dpms: SUCCESS (6.715s)
[517.540296] [095/155] (504s left) syncobj_eventfd (invalid-illegal-handle)
[517.597817] Starting subtest: invalid-illegal-handle
[517.600133] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[517.699988] [096/155] (504s left) kms_lease (lessee-list)
[517.791684] Starting subtest: lessee-list
[517.794037] Starting dynamic subtest: pipe-A-eDP-1
[517.796228] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[517.808727] Starting dynamic subtest: pipe-B-eDP-1
[517.810814] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[517.821090] Starting dynamic subtest: pipe-C-eDP-1
[517.823174] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[517.833525] Starting dynamic subtest: pipe-D-eDP-1
[517.835679] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[517.837819] Subtest lessee-list: SUCCESS (0.010s)
[517.912872] [097/155] (504s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[518.010703] Starting subtest: extended-pageflip-modeset-hang-oldfb
[518.012602] Starting dynamic subtest: pipe-A
[525.900265] Dynamic subtest pipe-A: SUCCESS (7.910s)
[525.915305] Starting dynamic subtest: pipe-D
[534.518176] Dynamic subtest pipe-D: SUCCESS (8.622s)
[534.520539] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.538s)
[535.368526] [098/155] (486s left) perf (i915-ref-count)
[535.428101] Starting subtest: i915-ref-count
[535.511876] Subtest i915-ref-count: SUCCESS (0.081s)
[535.584894] [099/155] (486s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[535.684885] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[535.690437] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[535.781002] [100/155] (486s left) perf (invalid-remove-userspace-config)
[535.866086] Starting subtest: invalid-remove-userspace-config
[535.874264] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[535.921655] [101/155] (486s left) gem_eio (wait-wedge-immediate)
[536.118499] Starting subtest: wait-wedge-immediate
[537.947989] Subtest wait-wedge-immediate: SUCCESS (1.828s)
[538.075483] [102/155] (484s left) kms_plane (plane-panning-bottom-right)
[538.171546] Starting subtest: plane-panning-bottom-right
[538.173883] Starting dynamic subtest: pipe-A
[539.861530] Dynamic subtest pipe-A: SUCCESS (1.688s)
[539.875502] Starting dynamic subtest: pipe-B
[542.340400] Dynamic subtest pipe-B: SUCCESS (2.473s)
[542.342983] Subtest plane-panning-bottom-right: SUCCESS (4.164s)
[543.223427] [103/155] (479s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[543.333564] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[543.335817] Starting dynamic subtest: pipe-A
[543.353731] Dynamic subtest pipe-A: SKIP (0.018s)
[543.365098] Starting dynamic subtest: pipe-B
[543.387682] Dynamic subtest pipe-B: SKIP (0.031s)
[543.398563] Starting dynamic subtest: pipe-C
[543.418770] Dynamic subtest pipe-C: SKIP (0.031s)
[543.429359] Starting dynamic subtest: pipe-D
[543.449080] Dynamic subtest pipe-D: SKIP (0.031s)
[543.453057] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.114s)
[543.558775] [104/155] (478s left) api_intel_bb (blit-reloc-keep-cache)
[543.621456] Starting subtest: blit-reloc-keep-cache
[543.625612] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[543.732884] [105/155] (478s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[543.830313] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[543.834597] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[543.932768] [106/155] (478s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[544.033727] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[544.036042] Starting dynamic subtest: pipe-A
[545.159784] Dynamic subtest pipe-A: SUCCESS (1.128s)
[545.172744] Starting dynamic subtest: pipe-B
[547.393331] Dynamic subtest pipe-B: SUCCESS (2.231s)
[547.404644] Starting dynamic subtest: pipe-C
[548.624672] Dynamic subtest pipe-C: SUCCESS (1.230s)
[548.636368] Starting dynamic subtest: pipe-D
[549.859717] Dynamic subtest pipe-D: SUCCESS (1.234s)
[549.862086] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.827s)
[551.050903] [107/155] (471s left) gem_mmap_offset (isolation)
[551.107589] Starting subtest: isolation
[551.124803] Subtest isolation: SUCCESS (0.006s)
[551.223159] [108/155] (471s left) kms_chamelium_hpd (common-hpd-after-suspend)
[551.599479] Subtest common-hpd-after-suspend: SKIP (0.000s)
[552.455526] [109/155] (470s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[552.545743] Starting subtest: crc-primary-suspend-y-tiled-ccs
[552.547992] Starting dynamic subtest: pipe-A-eDP-1
[552.557133] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[552.569077] Starting dynamic subtest: pipe-B-eDP-1
[552.578382] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[552.589085] Starting dynamic subtest: pipe-C-eDP-1
[552.597504] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[552.608346] Starting dynamic subtest: pipe-D-eDP-1
[552.616975] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[552.621073] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[554.820020] [110/155] (467s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[554.879532] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[554.940552] [111/155] (467s left) kms_flip (2x-flip-vs-fences)
[555.035762] Starting subtest: 2x-flip-vs-fences
[555.040265] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[555.156265] [112/155] (467s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[555.265054] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[555.933753] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s)
[556.108441] [113/155] (466s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[556.206100] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[563.508754] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.307s)
[563.637407] [114/155] (459s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[563.703120] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[563.809807] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[563.901809] [115/155] (458s left) gem_render_copy (linear-to-vebox-y-tiled)
[563.959431] Starting subtest: linear-to-vebox-y-tiled
[563.963961] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[564.157409] [116/155] (458s left) kms_lease (cursor-implicit-plane)
[564.255940] Starting subtest: cursor-implicit-plane
[564.258171] Starting dynamic subtest: pipe-A-eDP-1
[564.733561] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.479s)
[564.744656] Starting dynamic subtest: pipe-B-eDP-1
[565.829782] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.094s)
[565.841197] Starting dynamic subtest: pipe-C-eDP-1
[566.936106] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.102s)
[566.947874] Starting dynamic subtest: pipe-D-eDP-1
[568.066103] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[568.068285] Subtest cursor-implicit-plane: SUCCESS (3.812s)
[568.918240] [117/155] (453s left) kms_debugfs (display-off-read-all)
[569.023710] Starting subtest: display-off-read-all
[569.315023] Subtest display-off-read-all: SUCCESS (0.291s)
[570.151215] [118/155] (452s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[570.254200] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[570.258674] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[570.365836] [119/155] (452s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[570.427977] Starting subtest: basic-batch-kernel-default-cmd
[570.432559] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[570.617144] [120/155] (452s left) vgem_basic (sysfs)
[570.661739] Starting subtest: sysfs
[570.664085] Subtest sysfs: SUCCESS (0.000s)
[570.719894] [121/155] (452s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[570.822345] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[570.826538] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[570.923259] [122/155] (452s left) sw_sync (timeline_closed_signaled)
[570.959267] Starting subtest: timeline_closed_signaled
[570.961569] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[571.016171] [123/155] (452s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[571.115562] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[571.119889] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[571.215492] [124/155] (451s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[571.329703] Starting subtest: flip-vs-cursor-atomic
[578.943081] Subtest flip-vs-cursor-atomic: SUCCESS (7.614s)
[579.797207] [125/155] (443s left) perf_pmu (init-busy)
[579.842400] Starting subtest: init-busy
[579.844769] Starting dynamic subtest: rcs0
[579.846964] Dynamic subtest rcs0: SUCCESS (0.001s)
[579.858300] Starting dynamic subtest: bcs0
[579.860561] Dynamic subtest bcs0: SUCCESS (0.000s)
[579.871079] Starting dynamic subtest: vcs0
[579.873186] Dynamic subtest vcs0: SUCCESS (0.001s)
[579.883519] Starting dynamic subtest: vcs1
[579.885804] Dynamic subtest vcs1: SUCCESS (0.001s)
[579.896415] Starting dynamic subtest: vecs0
[579.898945] Dynamic subtest vecs0: SUCCESS (0.001s)
[579.909288] Starting dynamic subtest: ccs0
[579.912005] Dynamic subtest ccs0: SUCCESS (0.000s)
[579.914498] Subtest init-busy: SUCCESS (0.009s)
[579.969880] [126/155] (443s left) intel_hwmon (hwmon-read)
[580.025003] Subtest hwmon-read: SKIP (0.000s)
[580.085324] [127/155] (443s left) gem_exec_params (no-blt)
[580.141061] Starting subtest: no-blt
[580.146032] Subtest no-blt: SUCCESS (0.003s)
[580.264712] [128/155] (443s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[580.365357] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[580.369937] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[581.510497] [129/155] (441s left) kms_content_protection (dp-mst-type-0-hdcp14)
[581.648423] Starting subtest: dp-mst-type-0-hdcp14
[581.653118] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[581.788296] [130/155] (441s left) syncobj_timeline (single-wait-all-available-signaled)
[581.842778] Starting subtest: single-wait-all-available-signaled
[581.845122] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[581.939625] [131/155] (441s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt)
[582.041237] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt
[582.045748] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[582.138486] [132/155] (441s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[582.226725] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[582.230789] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[582.304437] [133/155] (441s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[582.391566] Starting subtest: fbc-psr2-cursor-mmap-cpu
[582.393376] Starting dynamic subtest: eDP-1
[582.396676] Dynamic subtest eDP-1: SKIP (0.000s)
[582.399930] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[582.466774] [134/155] (441s left) syncobj_wait (invalid-signal-one-illegal-handle)
[582.521643] Starting subtest: invalid-signal-one-illegal-handle
[582.523538] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[582.636797] [135/155] (441s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[582.734346] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[590.079898] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.351s)
[590.219244] [136/155] (433s left) kms_vblank (accuracy-idle)
[590.319530] Starting subtest: accuracy-idle
[590.321792] Starting dynamic subtest: pipe-A-eDP-1
[592.086103] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.765s)
[592.103670] Starting dynamic subtest: pipe-D-eDP-1
[594.497866] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.412s)
[594.500245] Subtest accuracy-idle: SUCCESS (4.181s)
[595.356513] [137/155] (428s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt)
[595.447817] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt
[595.452067] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[595.543679] [138/155] (428s left) kms_atomic (plane-invalid-params-fence)
[595.641779] Starting subtest: plane-invalid-params-fence
[595.644082] Starting dynamic subtest: pipe-A-eDP-1
[596.006657] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.364s)
[596.008997] Subtest plane-invalid-params-fence: SUCCESS (0.366s)
[596.855131] [139/155] (426s left) gem_exec_schedule (submit-late-slice)
[596.934996] Starting subtest: submit-late-slice
[596.937111] Starting dynamic subtest: rcs0
[596.965256] Dynamic subtest rcs0: SUCCESS (0.039s)
[596.982827] Starting dynamic subtest: bcs0
[597.010858] Dynamic subtest bcs0: SUCCESS (0.044s)
[597.022166] Starting dynamic subtest: vcs0
[597.044152] Dynamic subtest vcs0: SUCCESS (0.032s)
[597.059658] Starting dynamic subtest: vcs1
[597.086359] Dynamic subtest vcs1: SUCCESS (0.040s)
[597.100158] Starting dynamic subtest: vecs0
[597.120855] Dynamic subtest vecs0: SUCCESS (0.034s)
[597.131711] Starting dynamic subtest: ccs0
[597.165210] Dynamic subtest ccs0: SUCCESS (0.043s)
[597.167545] Subtest submit-late-slice: SUCCESS (0.240s)
[599.028858] [140/155] (424s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[599.150279] Starting subtest: flip-vs-cursor-varying-size
[608.355996] Subtest flip-vs-cursor-varying-size: SUCCESS (9.202s)
[609.196798] [141/155] (414s left) api_intel_bb (simple-bb-ctx)
[609.261208] Starting subtest: simple-bb-ctx
[609.267995] Subtest simple-bb-ctx: SUCCESS (0.009s)
[609.384345] [142/155] (414s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[609.482577] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[609.486706] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[609.582275] [143/155] (414s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt)
[609.677079] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt
[609.681431] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[609.786872] [144/155] (414s left) gem_lmem_swapping (heavy-verify-random)
[609.824279] Subtest heavy-verify-random: SKIP (0.000s)
[609.876208] [145/155] (414s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[609.975955] Starting subtest: bad-pixel-format-y-tiled-ccs
[609.978275] Starting dynamic subtest: pipe-A-eDP-1
[610.000588] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[610.013525] Starting dynamic subtest: pipe-B-eDP-1
[610.035056] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[610.045335] Starting dynamic subtest: pipe-C-eDP-1
[610.066731] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[610.076664] Starting dynamic subtest: pipe-D-eDP-1
[610.099481] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[610.103857] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[612.274744] [146/155] (411s left) kms_flip (dpms-vs-vblank-race)
[612.371901] Starting subtest: dpms-vs-vblank-race
[612.374179] Starting dynamic subtest: A-eDP1
[616.318651] Dynamic subtest A-eDP1: SUCCESS (3.946s)
[616.332828] Starting dynamic subtest: B-eDP1
[619.903823] Dynamic subtest B-eDP1: SUCCESS (3.581s)
[619.915501] Starting dynamic subtest: C-eDP1
[623.514152] Dynamic subtest C-eDP1: SUCCESS (3.609s)
[623.526182] Starting dynamic subtest: D-eDP1
[628.166356] Dynamic subtest D-eDP1: SUCCESS (4.651s)
[628.168535] Subtest dpms-vs-vblank-race: SUCCESS (15.795s)
[629.042959] [147/155] (395s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[629.146425] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[629.150672] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[629.251688] [148/155] (394s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite)
[629.358391] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite
[629.362549] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[629.463099] [149/155] (394s left) gem_flink_race (flink_close)
[629.496159] Starting subtest: flink_close
[634.577479] Subtest flink_close: SUCCESS (5.085s)
[634.711021] [150/155] (389s left) gem_exec_balancer (individual)
[634.777420] Starting subtest: individual
[636.891692] Subtest individual: SUCCESS (2.115s)
[637.214892] [151/155] (387s left) kms_feature_discovery (chamelium)
[637.312494] Starting subtest: chamelium
[637.317114] Subtest chamelium: SKIP (0.000s)
[637.400667] [152/155] (386s left) gem_ctx_persistence (hang)
[637.469671] Starting subtest: hang
[637.474269] Subtest hang: SKIP (0.000s)
[637.606136] [153/155] (386s left) fbdev (unaligned-read)
[637.650263] Starting subtest: unaligned-read
[637.666173] Subtest unaligned-read: SUCCESS (0.016s)
[637.723504] [154/155] (386s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-gtt)
[637.828159] Starting subtest: hdr-rgb101010-draw-mmap-gtt
[637.832502] Subtest hdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[637.917297] [155/155] (386s left) kms_cdclk (mode-transition)
[638.005344] Starting subtest: mode-transition
[638.007574] Starting dynamic subtest: pipe-A-eDP-1
[638.299612] Dynamic subtest pipe-A-eDP-1: SKIP (0.294s)
[638.315857] Starting dynamic subtest: pipe-B-eDP-1
[638.320895] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[638.331996] Starting dynamic subtest: pipe-C-eDP-1
[638.336423] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[638.346984] Starting dynamic subtest: pipe-D-eDP-1
[638.351364] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[638.355759] Subtest mode-transition: SKIP (0.302s)
[639.167386] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: gem_wait
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_async_flips
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_pm_rpm
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: drm_read
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_prop_blob
results: parsing output: 24/ for test: kms_hdr
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: prime_mmap
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_render_copy
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: dmabuf_sync_file
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_chamelium_edid
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: gem_close_race
results: parsing output: 46/ for test: gem_exec_capture
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_mmap_wc
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: gem_ctx_param
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: gen9_exec_parse
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_exec_whisper
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_color
results: parsing output: 59/ for test: gem_eio
results: parsing output: 60/ for test: i915_drm_fdinfo
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: i915_hangman
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_vblank
results: parsing output: 65/ for test: kms_pipe_crc_basic
results: parsing output: 66/ for test: prime_vgem
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_force_connector_basic
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_pxp
results: parsing output: 83/ for test: i915_pm_rpm
results: parsing output: 84/ for test: kms_rmfb
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: syncobj_basic
results: parsing output: 87/ for test: kms_pipe_crc_basic
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: syncobj_eventfd
results: parsing output: 95/ for test: kms_lease
results: parsing output: 96/ for test: kms_busy
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: gem_eio
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_plane_scaling
results: parsing output: 106/ for test: gem_mmap_offset
results: parsing output: 107/ for test: kms_chamelium_hpd
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_pipe_b_c_ivb
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_render_copy
results: parsing output: 115/ for test: kms_lease
results: parsing output: 116/ for test: kms_debugfs
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_flush
results: parsing output: 119/ for test: vgem_basic
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: intel_hwmon
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_content_protection
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_plane
results: parsing output: 132/ for test: kms_psr
results: parsing output: 133/ for test: syncobj_wait
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_vblank
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_atomic
results: parsing output: 138/ for test: gem_exec_schedule
results: parsing output: 139/ for test: kms_cursor_legacy
results: parsing output: 140/ for test: api_intel_bb
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: gem_lmem_swapping
results: parsing output: 144/ for test: kms_ccs
results: parsing output: 145/ for test: kms_flip
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_flink_race
results: parsing output: 149/ for test: gem_exec_balancer
results: parsing output: 150/ for test: kms_feature_discovery
results: parsing output: 151/ for test: gem_ctx_persistence
results: parsing output: 152/ for test: fbdev
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_cdclk
Done.