[57.226414] Initializing watchdogs
[57.226462]   /dev/watchdog0
[57.241406] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.245489] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.247553] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.251214] [001/156] (960s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[57.378776] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[57.383363] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[57.474713] [002/156] (960s left) gem_readwrite (new-obj)
[57.531923] Subtest new-obj: SKIP (0.000s)
[57.593808] [003/156] (960s left) kms_getfb (getfb-handle-not-fb)
[57.669182] Starting subtest: getfb-handle-not-fb
[57.671624] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[57.766940] [004/156] (960s left) sysfs_timeslice_duration (invalid)
[57.821128] Starting subtest: invalid
[57.823552] Starting dynamic subtest: vecs0
[57.825806] Dynamic subtest vecs0: SUCCESS (0.000s)
[57.835184] Starting dynamic subtest: ccs0
[57.837067] Dynamic subtest ccs0: SUCCESS (0.000s)
[57.844164] Starting dynamic subtest: vcs0
[57.846076] Dynamic subtest vcs0: SUCCESS (0.000s)
[57.853240] Starting dynamic subtest: bcs0
[57.855213] Dynamic subtest bcs0: SUCCESS (0.000s)
[57.862444] Starting dynamic subtest: rcs0
[57.864415] Dynamic subtest rcs0: SUCCESS (0.000s)
[57.872489] Starting dynamic subtest: vcs1
[57.875012] Dynamic subtest vcs1: SUCCESS (0.000s)
[57.877390] Subtest invalid: SUCCESS (0.003s)
[57.921542] [005/156] (959s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[58.291519] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[59.069968] [006/156] (958s left) gem_eio (execbuf)
[59.206196] Starting subtest: execbuf
[59.379771] Subtest execbuf: SUCCESS (0.170s)
[59.518202] [007/156] (958s left) kms_psr (psr-basic)
[59.595927] Starting subtest: psr-basic
[59.598949] Starting dynamic subtest: eDP-1
[61.301693] Dynamic subtest eDP-1: SUCCESS (1.692s)
[61.303874] Subtest psr-basic: SUCCESS (1.692s)
[62.178192] [008/156] (955s left) gem_basic (multigpu-create-close)
[62.235788] Starting subtest: multigpu-create-close
[62.240935] Subtest multigpu-create-close: SKIP (0.000s)
[62.334470] [009/156] (955s left) kms_frontbuffer_tracking (fbchdr-tiling-4)
[62.417809] Starting subtest: fbchdr-tiling-4
[62.421982] Subtest fbchdr-tiling-4: SKIP (0.000s)
[62.526319] [010/156] (955s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[62.884124] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[63.704728] [011/156] (954s left) gem_ctx_persistence (legacy-engines-mixed-process)
[63.763895] Starting subtest: legacy-engines-mixed-process
[63.766158] Starting dynamic subtest: render
[65.214453] Dynamic subtest render: SUCCESS (1.444s)
[65.224329] Starting dynamic subtest: bsd1
[67.216767] Dynamic subtest bsd1: SUCCESS (1.995s)
[67.231087] Starting dynamic subtest: bsd2
[69.266917] Dynamic subtest bsd2: SUCCESS (2.043s)
[69.277840] Starting dynamic subtest: blt
[71.247223] Dynamic subtest blt: SUCCESS (1.975s)
[71.257709] Starting dynamic subtest: vebox
[73.243368] Dynamic subtest vebox: SUCCESS (1.992s)
[73.245998] Subtest legacy-engines-mixed-process: SUCCESS (9.454s)
[73.320348] [012/156] (944s left) drm_read (short-buffer-nonblock)
[73.502100] Starting subtest: short-buffer-nonblock
[73.504421] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[73.624952] [013/156] (944s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[73.715697] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[73.719798] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[73.806604] [014/156] (944s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[73.896625] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[73.900605] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[73.980920] [015/156] (944s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[74.060410] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[81.448893] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.390s)
[81.575769] [016/156] (936s left) gem_softpin (allocator-nopin-reserve)
[81.628302] Starting subtest: allocator-nopin-reserve
[81.720572] Subtest allocator-nopin-reserve: SUCCESS (0.094s)
[81.840902] [017/156] (936s left) perf_pmu (render-node-busy-idle)
[81.935622] Starting subtest: render-node-busy-idle
[81.938092] Starting dynamic subtest: rcs0
[82.643568] Dynamic subtest rcs0: SUCCESS (0.708s)
[82.654121] Starting dynamic subtest: bcs0
[83.305997] Dynamic subtest bcs0: SUCCESS (0.661s)
[83.318029] Starting dynamic subtest: vcs0
[85.248100] Dynamic subtest vcs0: SUCCESS (1.939s)
[85.259715] Starting dynamic subtest: vcs1
[87.231856] Dynamic subtest vcs1: SUCCESS (1.980s)
[87.244804] Starting dynamic subtest: vecs0
[89.215695] Dynamic subtest vecs0: SUCCESS (1.982s)
[89.228044] Starting dynamic subtest: ccs0
[89.892182] Dynamic subtest ccs0: SUCCESS (0.677s)
[89.894685] Subtest render-node-busy-idle: SUCCESS (7.954s)
[89.966627] [018/156] (928s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[90.057323] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[90.061268] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[90.163321] [019/156] (928s left) kms_vblank (wait-idle)
[90.242801] Starting subtest: wait-idle
[90.245134] Starting dynamic subtest: pipe-A-eDP-1
[91.995168] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[92.008178] Starting dynamic subtest: pipe-D-eDP-1
[94.425562] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.424s)
[94.427815] Subtest wait-idle: SUCCESS (4.179s)
[95.242092] [020/156] (923s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[95.299312] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[95.405105] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.105s)
[95.492615] [021/156] (923s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[95.589597] Starting subtest: hdr-rgb565-draw-render
[95.593940] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[95.692968] [022/156] (922s left) gem_ctx_exec (basic-close-race)
[95.739732] Starting subtest: basic-close-race
[101.531135] Subtest basic-close-race: SUCCESS (5.789s)
[101.652686] [023/156] (916s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[101.732086] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[101.736190] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[101.795900] [024/156] (916s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[101.869372] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[101.873766] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[101.966170] [025/156] (916s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[102.028901] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[102.031161] Starting dynamic subtest: pipe-A-eDP-1
[102.054391] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[102.064498] Starting dynamic subtest: pipe-B-eDP-1
[102.086212] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[102.094914] Starting dynamic subtest: pipe-C-eDP-1
[102.115972] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[102.124587] Starting dynamic subtest: pipe-D-eDP-1
[102.147331] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[102.151468] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.002s)
[104.325115] [026/156] (914s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[104.408988] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[108.918645] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.514s)
[110.132392] [027/156] (908s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt)
[110.214474] Starting subtest: fbchdr-farfromfence-mmap-gtt
[110.218774] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s)
[110.299406] [028/156] (908s left) kms_plane_alpha_blend (constant-alpha-mid)
[110.375827] Starting subtest: constant-alpha-mid
[110.652572] Starting dynamic subtest: pipe-A-eDP-1
[111.463303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[111.473667] Starting dynamic subtest: pipe-D-eDP-1
[112.941329] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.477s)
[112.943746] Subtest constant-alpha-mid: SUCCESS (2.566s)
[113.790147] [029/156] (905s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[113.866250] Starting subtest: fbc-pr-sprite-mmap-cpu
[113.870805] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[113.939544] [030/156] (904s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[114.018684] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[114.022637] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[114.104143] [031/156] (904s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[114.180874] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[118.633226] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.459s)
[119.797140] [032/156] (899s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[119.857540] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[119.861885] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[120.041280] [033/156] (898s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[120.119436] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[120.123600] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[120.213990] [034/156] (898s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[120.292252] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[120.296350] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[120.395483] [035/156] (898s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[120.459276] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[120.512876] [036/156] (898s left) kms_cdclk (plane-scaling)
[120.585219] Starting subtest: plane-scaling
[120.587602] Starting dynamic subtest: pipe-A-eDP-1
[120.875996] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[120.884892] Starting dynamic subtest: pipe-B-eDP-1
[120.889558] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[120.898780] Starting dynamic subtest: pipe-C-eDP-1
[120.903525] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[120.912677] Starting dynamic subtest: pipe-D-eDP-1
[120.916914] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[120.921126] Subtest plane-scaling: SKIP (0.294s)
[121.707048] [037/156] (897s left) kms_frontbuffer_tracking (fbchdr-1p-rte)
[121.791678] Starting subtest: fbchdr-1p-rte
[121.795800] Subtest fbchdr-1p-rte: SKIP (0.000s)
[121.872881] [038/156] (897s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[121.962618] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[121.966534] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[122.051890] [039/156] (897s left) gem_exec_reloc (basic-range-active)
[122.116814] Subtest basic-range-active: SKIP (0.000s)
[122.180565] [040/156] (897s left) syncobj_timeline (etime-single-wait-submitted)
[122.233030] Starting subtest: etime-single-wait-submitted
[122.339272] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[122.416122] [041/156] (896s left) api_intel_allocator (reopen)
[122.477135] Starting subtest: reopen
[122.482326] Subtest reopen: SUCCESS (0.004s)
[122.606114] [042/156] (896s left) gem_exec_reloc (basic-write-read)
[122.668340] Subtest basic-write-read: SKIP (0.000s)
[122.740285] [043/156] (896s left) gem_sync (basic-many-each)
[122.807714] Starting subtest: basic-many-each
[125.102795] Subtest basic-many-each: SUCCESS (2.306s)
[125.283709] [044/156] (894s left) kms_async_flips (async-flip-suspend-resume)
[125.359143] Starting subtest: async-flip-suspend-resume
[125.749445] Starting dynamic subtest: pipe-A-eDP-1
[143.245520] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.776s)
[143.624195] Starting dynamic subtest: pipe-B-eDP-1
[161.256743] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.860s)
[161.643933] Starting dynamic subtest: pipe-C-eDP-1
[179.240932] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.857s)
[179.602034] Starting dynamic subtest: pipe-D-eDP-1
[197.243688] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.940s)
[197.246725] Subtest async-flip-suspend-resume: SUCCESS (13.934s)
[198.499976] [045/156] (820s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[198.595205] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[198.597586] Starting dynamic subtest: pipe-A-eDP-1
[198.620918] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[198.635839] Starting dynamic subtest: pipe-B-eDP-1
[198.657291] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[198.668495] Starting dynamic subtest: pipe-C-eDP-1
[198.689529] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[198.699362] Starting dynamic subtest: pipe-D-eDP-1
[198.720832] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[198.725002] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[200.898907] [046/156] (818s left) kms_sequence (get-idle)
[200.989678] Starting subtest: get-idle
[200.991999] Starting dynamic subtest: pipe-A-eDP-1
[202.942912] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s)
[202.956672] Starting dynamic subtest: pipe-B-eDP-1
[205.320204] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.357s)
[205.330743] Starting dynamic subtest: pipe-C-eDP-1
[207.770964] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.433s)
[207.782658] Starting dynamic subtest: pipe-D-eDP-1
[210.219755] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.435s)
[210.222061] Subtest get-idle: SUCCESS (9.155s)
[211.028261] [047/156] (808s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[211.117151] Starting subtest: 4-tiled-16bpp-rotate-90
[211.136626] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[211.248708] [048/156] (808s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[211.335017] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[211.339221] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[211.440063] [049/156] (808s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[211.498470] Starting subtest: yf-tiled-ccs-to-y-tiled
[211.503176] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[211.681145] [050/156] (807s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt)
[211.754545] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt
[211.759152] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[211.849517] [051/156] (807s left) prime_busy (hang-wait)
[211.903343] Starting subtest: hang-wait
[211.905712] Starting dynamic subtest: rcs0
[238.541930] Dynamic subtest rcs0: SUCCESS (26.607s)
[238.551426] Starting dynamic subtest: bcs0
[245.639846] Dynamic subtest bcs0: SUCCESS (7.095s)
[245.652344] Starting dynamic subtest: vcs0
[252.609644] Dynamic subtest vcs0: SUCCESS (6.967s)
[252.621770] Starting dynamic subtest: vcs1
[259.652527] Dynamic subtest vcs1: SUCCESS (7.039s)
[259.664566] Starting dynamic subtest: vecs0
[266.681022] Dynamic subtest vecs0: SUCCESS (7.028s)
[266.693839] Starting dynamic subtest: ccs0
[280.527857] Dynamic subtest ccs0: SUCCESS (13.836s)
[280.530528] Subtest hang-wait: SUCCESS (68.582s)
[280.654723] [052/156] (739s left) gem_eio (hibernate)
[280.839897] Starting subtest: hibernate
[294.229041] Subtest hibernate: SUCCESS (13.382s)
[302.387814] [053/156] (725s left) gem_mmap (bad-object)
[302.451405] Subtest bad-object: SKIP (0.000s)
[302.506414] [054/156] (725s left) kms_feature_discovery (display-3x)
[302.575822] Starting subtest: display-3x
[302.580223] Subtest display-3x: SKIP (0.000s)
[302.648747] [055/156] (725s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt)
[302.724905] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt
[302.729117] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[302.832996] [056/156] (725s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt)
[302.919069] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt
[302.923252] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[303.014749] [057/156] (724s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[303.081726] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[303.084035] Starting dynamic subtest: pipe-A-eDP-1
[303.139169] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[303.149099] Starting dynamic subtest: pipe-B-eDP-1
[303.204878] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[303.216293] Starting dynamic subtest: pipe-C-eDP-1
[303.274083] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[303.285682] Starting dynamic subtest: pipe-D-eDP-1
[303.344330] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[303.348377] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[305.363028] [058/156] (722s left) kms_content_protection (atomic-hdcp14)
[305.476607] Starting subtest: atomic-hdcp14
[305.481118] Subtest atomic-hdcp14: SKIP (0.000s)
[305.608761] [059/156] (722s left) kms_psr (psr-suspend)
[305.679134] Starting subtest: psr-suspend
[305.681974] Starting dynamic subtest: eDP-1
[323.686167] Dynamic subtest eDP-1: SUCCESS (2.967s)
[323.688540] Subtest psr-suspend: SUCCESS (2.968s)
[324.571249] [060/156] (703s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[324.667981] Starting subtest: yf-tiled-16bpp-rotate-0
[324.672509] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[324.778195] [061/156] (703s left) gem_exec_flush (basic-wb-ro-before-default)
[324.844871] Starting subtest: basic-wb-ro-before-default
[330.377871] Subtest basic-wb-ro-before-default: SUCCESS (5.455s)
[330.561900] [062/156] (697s left) i915_pm_rpm (system-suspend-execbuf)
[332.068859] Starting subtest: system-suspend-execbuf
[392.393301] Subtest system-suspend-execbuf: SUCCESS (45.030s)
[392.770409] [063/156] (635s left) gem_partial_pwrite_pread (writes-after-reads-display)
[392.839496] Subtest writes-after-reads-display: SKIP (0.000s)
[392.920847] [064/156] (635s left) kms_setmode (invalid-clone-single-crtc-stealing)
[392.979607] Starting subtest: invalid-clone-single-crtc-stealing
[392.985998] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[393.089008] [065/156] (635s left) i915_suspend (basic-s2idle-without-i915)
[393.124411] Starting subtest: basic-s2idle-without-i915
[413.664405] Subtest basic-s2idle-without-i915: SUCCESS (5.519s)
[413.771738] [066/156] (614s left) gem_exec_create (madvise)
[413.858678] Starting subtest: madvise
[413.860879] Starting dynamic subtest: smem
[435.201957] Dynamic subtest smem: SUCCESS (21.189s)
[435.204828] Subtest madvise: SUCCESS (21.190s)
[436.063056] [067/156] (592s left) gem_ctx_shared (q-smoketest)
[436.134035] Starting subtest: Q-smoketest
[436.136324] Starting dynamic subtest: rcs0
[441.698644] Dynamic subtest rcs0: SUCCESS (5.505s)
[441.711380] Starting dynamic subtest: bcs0
[447.211936] Dynamic subtest bcs0: SUCCESS (5.516s)
[447.229081] Starting dynamic subtest: vcs0
[452.688848] Dynamic subtest vcs0: SUCCESS (5.472s)
[452.703681] Starting dynamic subtest: vcs1
[458.165888] Dynamic subtest vcs1: SUCCESS (5.471s)
[458.182684] Starting dynamic subtest: vecs0
[463.653448] Dynamic subtest vecs0: SUCCESS (5.487s)
[463.665126] Starting dynamic subtest: ccs0
[469.162040] Dynamic subtest ccs0: SUCCESS (5.510s)
[469.164460] Subtest Q-smoketest: SUCCESS (32.968s)
[469.305428] [068/156] (559s left) gem_exec_reloc (basic-cpu-active)
[469.363008] Subtest basic-cpu-active: SKIP (0.000s)
[469.443382] [069/156] (559s left) gem_watchdog (default-physical)
[469.512386] Starting subtest: default-physical
[471.276244] Subtest default-physical: SUCCESS (1.776s)
[471.367381] [070/156] (557s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[471.458089] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[471.462484] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[471.542200] [071/156] (556s left) gen9_exec_parse (bb-start-param)
[471.605633] Subtest bb-start-param: SKIP (0.000s)
[471.677553] [072/156] (556s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[471.761118] Starting subtest: fbc-psr2-cursor-plane-update-sf
[471.763507] Starting dynamic subtest: pipe-A-eDP-1
[471.859537] Dynamic subtest pipe-A-eDP-1: SKIP (0.102s)
[471.869848] Starting dynamic subtest: pipe-B-eDP-1
[473.041478] Dynamic subtest pipe-B-eDP-1: SKIP (1.179s)
[473.046245] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.284s)
[474.229559] [073/156] (554s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[474.314418] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[474.318539] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[474.421554] [074/156] (554s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[474.493157] Starting subtest: compare-crc-sanitycheck-xr24
[474.495530] Starting dynamic subtest: pipe-A-eDP-1
[475.118182] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.622s)
[475.131305] Starting dynamic subtest: pipe-B-eDP-1
[476.394228] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.276s)
[476.404430] Starting dynamic subtest: pipe-C-eDP-1
[477.610083] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.213s)
[477.620536] Starting dynamic subtest: pipe-D-eDP-1
[478.814664] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.203s)
[478.817031] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.320s)
[479.671974] [075/156] (549s left) syncobj_timeline (multi-wait-all-signaled)
[479.718731] Starting subtest: multi-wait-all-signaled
[479.720736] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[479.819621] [076/156] (548s left) kms_psr (pr-primary-mmap-gtt)
[479.903142] Starting subtest: pr-primary-mmap-gtt
[479.907655] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[479.987382] [077/156] (548s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[480.061475] Starting subtest: blocking-absolute-wf_vblank-interruptible
[480.063788] Starting dynamic subtest: A-eDP1
[488.828103] Dynamic subtest A-eDP1: SUCCESS (8.761s)
[488.841049] Starting dynamic subtest: B-eDP1
[497.562579] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[497.577433] Starting dynamic subtest: C-eDP1
[506.287820] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[506.299121] Starting dynamic subtest: D-eDP1
[515.016886] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[515.022252] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.951s)
[516.230527] [078/156] (512s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[516.306050] Starting subtest: plane-upscale-factor-0-25-with-rotation
[516.308346] Starting dynamic subtest: pipe-A
[516.531132] Dynamic subtest pipe-A: SUCCESS (0.226s)
[516.541306] Starting dynamic subtest: pipe-B
[517.812008] Dynamic subtest pipe-B: SUCCESS (1.280s)
[517.822299] Starting dynamic subtest: pipe-C
[519.143258] Dynamic subtest pipe-C: SUCCESS (1.330s)
[519.153583] Starting dynamic subtest: pipe-D
[520.482307] Dynamic subtest pipe-D: SUCCESS (1.338s)
[520.484692] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.179s)
[521.667155] [079/156] (507s left) api_intel_bb (reset-bb)
[521.720549] Starting subtest: reset-bb
[521.722590] Subtest reset-bb: SUCCESS (0.004s)
[521.853348] [080/156] (507s left) gem_lmem_swapping (heavy-random)
[521.894574] Subtest heavy-random: SKIP (0.000s)
[521.934172] [081/156] (506s left) gem_mmap_gtt (basic-write)
[521.985443] Subtest basic-write: SKIP (0.000s)
[522.041401] [082/156] (506s left) gem_request_retire (retire-vma-not-inactive)
[522.095742] Starting subtest: retire-vma-not-inactive
[522.155969] Subtest retire-vma-not-inactive: SUCCESS (0.059s)
[522.262946] [083/156] (506s left) kms_cursor_crc (cursor-offscreen-512x170)
[522.503150] Starting subtest: cursor-offscreen-512x170
[522.507754] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[522.635063] [084/156] (506s left) gem_softpin (noreloc-s3)
[522.693478] Starting subtest: noreloc-S3
[542.450450] Subtest noreloc-S3: SUCCESS (5.428s)
[542.595233] [085/156] (486s left) kms_psr (fbc-psr2-primary-blt)
[542.691884] Starting subtest: fbc-psr2-primary-blt
[542.694101] Starting dynamic subtest: eDP-1
[542.698159] Dynamic subtest eDP-1: SKIP (0.000s)
[542.702243] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[542.764672] [086/156] (486s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[542.850074] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite
[542.854266] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[542.948743] [087/156] (486s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[543.022835] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[543.026582] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[543.093462] [088/156] (486s left) gem_exec_schedule (wide)
[543.275412] Starting subtest: wide
[543.277549] Starting dynamic subtest: rcs0
[552.868721] Dynamic subtest rcs0: SUCCESS (9.517s)
[552.884908] Starting dynamic subtest: vcs0
[562.984002] Dynamic subtest vcs0: SUCCESS (10.089s)
[562.997716] Starting dynamic subtest: vcs1
[573.080972] Dynamic subtest vcs1: SUCCESS (10.087s)
[573.095914] Starting dynamic subtest: vecs0
[583.219565] Dynamic subtest vecs0: SUCCESS (10.137s)
[583.232445] Starting dynamic subtest: ccs0
[595.612385] Dynamic subtest ccs0: SUCCESS (12.389s)
[595.614809] Subtest wide: SUCCESS (52.225s)
[597.536118] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[597.539416] [089/156] (431s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[597.618980] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[604.957337] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.340s)
[605.093898] [090/156] (424s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[605.178600] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[605.180856] Starting dynamic subtest: pipe-A-eDP-1
[605.189613] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[605.200988] Starting dynamic subtest: pipe-B-eDP-1
[605.209775] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[605.220588] Starting dynamic subtest: pipe-C-eDP-1
[605.228944] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[605.242539] Starting dynamic subtest: pipe-D-eDP-1
[605.251107] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[605.255176] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[607.507329] [091/156] (421s left) drm_mm (drm_mm)
[607.547468] Starting subtest: drm_mm
[607.588603] Starting dynamic subtest: drm_test_mm_init
[607.679599] Dynamic subtest drm_test_mm_init: SUCCESS (0.089s)
[607.691289] Starting dynamic subtest: drm_test_mm_debug
[607.771918] Dynamic subtest drm_test_mm_debug: SUCCESS (0.092s)
[607.782607] Starting dynamic subtest: drm_test_mm_align32
[607.866629] Dynamic subtest drm_test_mm_align32: SUCCESS (0.092s)
[607.879655] Starting dynamic subtest: drm_test_mm_align64
[607.962557] Dynamic subtest drm_test_mm_align64: SUCCESS (0.096s)
[607.974020] Starting dynamic subtest: drm_test_mm_lowest
[608.072998] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.108s)
[608.085111] Starting dynamic subtest: drm_test_mm_highest
[608.175851] Dynamic subtest drm_test_mm_highest: SUCCESS (0.102s)
[608.177893] Subtest drm_mm: SUCCESS (0.629s)
[608.320935] [092/156] (421s left) gem_exec_balancer (hang)
[608.586331] Starting subtest: hang
[610.410868] Subtest hang: SUCCESS (1.827s)
[610.531709] [093/156] (418s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[610.579353] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[610.581717] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[610.670828] [094/156] (418s left) kms_cursor_crc (cursor-random-64x64)
[610.819343] Starting subtest: cursor-random-64x64
[610.821681] Starting dynamic subtest: pipe-A-eDP-1
[614.135944] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.310s)
[614.165357] Starting dynamic subtest: pipe-D-eDP-1
[618.119549] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.961s)
[618.121852] Subtest cursor-random-64x64: SUCCESS (7.298s)
[618.992478] [095/156] (410s left) gem_mmap_offset (ptrace)
[619.049058] Starting subtest: ptrace
[619.051393] Starting dynamic subtest: smem0-wb
[619.070414] Dynamic subtest smem0-wb: SUCCESS (0.020s)
[619.082213] Starting dynamic subtest: smem0-wc
[619.088288] Dynamic subtest smem0-wc: SUCCESS (0.017s)
[619.100136] Starting dynamic subtest: smem0-uc
[619.106978] Dynamic subtest smem0-uc: SUCCESS (0.018s)
[619.109144] Subtest ptrace: SUCCESS (0.061s)
[619.220327] [096/156] (410s left) kms_addfb_basic (unused-offsets)
[619.277327] Starting subtest: unused-offsets
[619.279676] Subtest unused-offsets: SUCCESS (0.000s)
[619.393298] [097/156] (410s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[619.471624] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[619.475872] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[619.571772] [098/156] (410s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[619.659872] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[619.664028] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[619.763698] [099/156] (409s left) kms_fbcon_fbt (psr)
[619.818320] Starting subtest: psr
[627.246518] Subtest psr: SUCCESS (7.421s)
[627.322544] [100/156] (402s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-render)
[627.402080] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-render
[627.406306] Subtest psrhdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[627.511752] [101/156] (402s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[627.598208] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[627.602586] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[627.700510] [102/156] (402s left) gem_exec_schedule (preempt-engines)
[627.767031] Starting subtest: preempt-engines
[627.769202] Starting dynamic subtest: rcs0
[629.995930] Dynamic subtest rcs0: SUCCESS (2.235s)
[630.011567] Starting dynamic subtest: bcs0
[632.233835] Dynamic subtest bcs0: SUCCESS (2.234s)
[632.250907] Starting dynamic subtest: vcs0
[634.493905] Dynamic subtest vcs0: SUCCESS (2.258s)
[634.516060] Starting dynamic subtest: vcs1
[636.752967] Dynamic subtest vcs1: SUCCESS (2.257s)
[636.769527] Starting dynamic subtest: vecs0
[639.008215] Dynamic subtest vecs0: SUCCESS (2.254s)
[639.022157] Starting dynamic subtest: ccs0
[641.303191] Dynamic subtest ccs0: SUCCESS (2.294s)
[641.305711] Subtest preempt-engines: SUCCESS (13.544s)
[641.601053] [103/156] (388s left) perf_pmu (busy-accuracy-50)
[641.638472] Starting subtest: busy-accuracy-50
[641.640801] Starting dynamic subtest: rcs0
[643.175204] Dynamic subtest rcs0: SUCCESS (1.536s)
[643.187998] Starting dynamic subtest: bcs0
[644.722266] Dynamic subtest bcs0: SUCCESS (1.545s)
[644.736354] Starting dynamic subtest: vcs0
[646.259769] Dynamic subtest vcs0: SUCCESS (1.535s)
[646.274197] Starting dynamic subtest: vcs1
[647.802204] Dynamic subtest vcs1: SUCCESS (1.540s)
[647.816066] Starting dynamic subtest: vecs0
[649.341436] Dynamic subtest vecs0: SUCCESS (1.536s)
[649.356666] Starting dynamic subtest: ccs0
[650.880617] Dynamic subtest ccs0: SUCCESS (1.537s)
[650.882750] Subtest busy-accuracy-50: SUCCESS (9.244s)
[650.999601] [104/156] (378s left) kms_cursor_legacy (forked-bo)
[651.095719] Starting subtest: forked-bo
[651.097586] Starting dynamic subtest: pipe-A
[656.552583] Dynamic subtest pipe-A: SUCCESS (5.455s)
[656.576878] Starting dynamic subtest: pipe-B
[662.014543] Dynamic subtest pipe-B: SUCCESS (5.460s)
[662.028548] Starting dynamic subtest: pipe-C
[667.492533] Dynamic subtest pipe-C: SUCCESS (5.476s)
[667.518032] Starting dynamic subtest: pipe-D
[672.960226] Dynamic subtest pipe-D: SUCCESS (5.466s)
[672.973778] Starting dynamic subtest: all-pipes
[678.470282] Dynamic subtest all-pipes: SUCCESS (5.507s)
[678.472846] Subtest forked-bo: SUCCESS (27.373s)
[678.632413] [105/156] (351s left) perf (invalid-oa-metric-set-id)
[678.788111] Starting subtest: invalid-oa-metric-set-id
[678.800633] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[678.846202] [106/156] (351s left) kms_lease (atomic-implicit-crtc)
[678.925445] Starting subtest: atomic-implicit-crtc
[678.927771] Starting dynamic subtest: pipe-A-eDP-1
[678.939014] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[678.951223] Starting dynamic subtest: pipe-B-eDP-1
[678.963031] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[678.978826] Starting dynamic subtest: pipe-C-eDP-1
[678.989253] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[679.000554] Starting dynamic subtest: pipe-D-eDP-1
[679.011329] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[679.013632] Subtest atomic-implicit-crtc: SUCCESS (0.038s)
[679.076174] [107/156] (350s left) vgem_basic (dmabuf-fence-before)
[679.115865] Starting subtest: dmabuf-fence-before
[679.118106] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[679.177216] [108/156] (350s left) gem_ctx_param (invalid-set-no-zeromap)
[679.228229] Starting subtest: invalid-set-no-zeromap
[679.230463] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[679.312915] [109/156] (350s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[679.403006] Starting subtest: y-tiled-16bpp-rotate-180
[679.407030] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[679.504814] [110/156] (350s left) kms_prime (basic-crc-hybrid)
[679.568176] Subtest basic-crc-hybrid: SKIP (0.000s)
[679.672283] [111/156] (350s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[679.743310] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[679.746774] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[679.858254] [112/156] (350s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[679.912572] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[679.914502] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[680.010259] [113/156] (350s left) gem_render_copy_redux (interruptible)
[680.063768] Starting subtest: interruptible
[680.319005] Subtest interruptible: SUCCESS (0.255s)
[680.448710] [114/156] (349s left) kms_big_fb (linear-addfb)
[680.533392] Starting subtest: linear-addfb
[680.535574] Subtest linear-addfb: SUCCESS (0.000s)
[680.645657] [115/156] (349s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[680.732018] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[680.735236] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[680.815486] [116/156] (349s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[680.902051] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[680.905659] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[681.014125] [117/156] (349s left) kms_psr (fbc-psr-suspend)
[681.080561] Starting subtest: fbc-psr-suspend
[681.082531] Starting dynamic subtest: eDP-1
[681.086082] Dynamic subtest eDP-1: SKIP (0.000s)
[681.089655] Subtest fbc-psr-suspend: SKIP (0.001s)
[681.160022] [118/156] (349s left) kms_atomic_transition (modeset-transition-fencing)
[681.238763] Starting subtest: modeset-transition-fencing
[681.240543] Starting dynamic subtest: 1x-outputs
[692.399577] Dynamic subtest 1x-outputs: SUCCESS (11.160s)
[692.402020] Subtest modeset-transition-fencing: SUCCESS (11.162s)
[693.256788] [119/156] (337s left) gem_exec_schedule (semaphore-user)
[693.338054] Starting subtest: semaphore-user
[693.388278] Subtest semaphore-user: SUCCESS (0.058s)
[695.446448] [120/156] (335s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[695.530023] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[695.534242] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[695.625365] [121/156] (334s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[695.700650] Starting subtest: fbcpsrhdr-tiling-linear
[695.704869] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[695.804834] [122/156] (334s left) gem_exec_fence (submit)
[695.981244] Starting subtest: submit
[695.986015] Subtest submit: SKIP (0.000s)
[697.471709] [123/156] (333s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[697.556186] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[697.560573] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[697.658188] [124/156] (333s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[697.741154] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[697.745240] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[697.837034] [125/156] (332s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[697.924474] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[697.928564] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[698.024119] [126/156] (332s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[698.106925] Starting subtest: psr-rgb101010-draw-mmap-gtt
[698.111091] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[698.218452] [127/156] (332s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[698.276788] Starting subtest: multi-wait-all-for-submit-submitted
[698.385178] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[698.472347] [128/156] (332s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[698.550738] Starting subtest: plane-lut1d-ctm3x4
[698.675363] Starting dynamic subtest: pipe-A-plane-0
[698.819179] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[698.838181] Starting dynamic subtest: pipe-A-plane-1
[698.952818] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[698.964820] Starting dynamic subtest: pipe-A-plane-2
[699.085828] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[700.288950] Starting dynamic subtest: pipe-B-plane-0
[700.466822] Dynamic subtest pipe-B-plane-0: SUCCESS (0.188s)
[700.478396] Starting dynamic subtest: pipe-B-plane-1
[700.600114] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[700.612331] Starting dynamic subtest: pipe-B-plane-2
[700.733798] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[701.976959] Starting dynamic subtest: pipe-C-plane-0
[702.110750] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[702.123233] Starting dynamic subtest: pipe-C-plane-1
[702.244589] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[702.259263] Starting dynamic subtest: pipe-C-plane-2
[702.389188] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[703.629593] Starting dynamic subtest: pipe-D-plane-0
[703.763238] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[703.775506] Starting dynamic subtest: pipe-D-plane-1
[703.907683] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[703.919083] Starting dynamic subtest: pipe-D-plane-2
[704.063453] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[704.353040] Subtest plane-lut1d-ctm3x4: SUCCESS (5.800s)
[705.186403] [129/156] (325s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[705.261610] Starting subtest: fb-8bpc-vs-panel-6bpc
[705.263881] Starting dynamic subtest: pipe-A-eDP-1
[706.659418] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.397s)
[706.661665] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.398s)
[707.545960] [130/156] (323s left) gem_userptr_blits (unsync-unmap)
[707.616995] Subtest unsync-unmap: SKIP (0.000s)
[707.737916] [131/156] (323s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[707.820398] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[707.824610] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[707.933271] [132/156] (323s left) kms_pm_dc (dc9-dpms)
[709.004557] Starting subtest: dc9-dpms
[710.432609] Subtest dc9-dpms: SUCCESS (1.429s)
[710.507611] [133/156] (320s left) i915_hangman (engine-error-state-capture)
[710.574002] Starting subtest: engine-error-state-capture
[710.576295] Starting dynamic subtest: rcs0
[714.379297] Dynamic subtest rcs0: SUCCESS (3.804s)
[714.394474] Starting dynamic subtest: bcs0
[720.332596] Dynamic subtest bcs0: SUCCESS (5.949s)
[720.349059] Starting dynamic subtest: vcs0
[726.347779] Dynamic subtest vcs0: SUCCESS (6.011s)
[726.366469] Starting dynamic subtest: vcs1
[732.363223] Dynamic subtest vcs1: SUCCESS (6.011s)
[732.377242] Starting dynamic subtest: vecs0
[738.315273] Dynamic subtest vecs0: SUCCESS (5.947s)
[738.329563] Starting dynamic subtest: ccs0
[744.331914] Dynamic subtest ccs0: SUCCESS (6.011s)
[744.335169] Subtest engine-error-state-capture: SUCCESS (33.749s)
[744.414669] [134/156] (286s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[744.496907] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[744.499158] Starting dynamic subtest: pipe-A-default-mode
[745.658476] Dynamic subtest pipe-A-default-mode: SKIP (1.158s)
[745.663321] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.159s)
[745.805051] [135/156] (285s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu)
[745.883631] Starting subtest: psrhdr-rgb565-draw-mmap-cpu
[745.887821] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[745.987044] [136/156] (285s left) gem_exec_params (readonly)
[746.046764] Starting subtest: readonly
[746.049133] Subtest readonly: SUCCESS (0.002s)
[746.174361] [137/156] (285s left) kms_busy (extended-pageflip-hang-newfb)
[746.246415] Starting subtest: extended-pageflip-hang-newfb
[746.248703] Starting dynamic subtest: pipe-A
[772.222759] Dynamic subtest pipe-A: SUCCESS (25.971s)
[772.235068] Starting dynamic subtest: pipe-D
[787.213416] Dynamic subtest pipe-D: SUCCESS (14.991s)
[787.215669] Subtest extended-pageflip-hang-newfb: SUCCESS (40.968s)
[788.097769] [138/156] (243s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[788.187333] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[788.191484] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[788.295240] [139/156] (243s left) i915_drm_fdinfo (context-close-stress)
[788.338429] Starting subtest: context-close-stress
[799.082135] Subtest context-close-stress: SUCCESS (10.745s)
[799.188178] [140/156] (232s left) gem_exec_flush (basic-batch-kernel-default-uc)
[799.371002] Starting subtest: basic-batch-kernel-default-uc
[805.708372] Subtest basic-batch-kernel-default-uc: SUCCESS (6.338s)
[805.904878] [141/156] (225s left) syncobj_timeline (wait-any-interrupted)
[805.969285] Starting subtest: wait-any-interrupted
[806.071892] Subtest wait-any-interrupted: SUCCESS (0.104s)
[806.150263] [142/156] (225s left) prime_mmap (test_dup)
[806.197806] Starting subtest: test_dup
[806.200107] Starting dynamic subtest: test_dup-smem
[806.236006] Dynamic subtest test_dup-smem: SUCCESS (0.038s)
[806.238211] Subtest test_dup: SUCCESS (0.039s)
[806.326045] [143/156] (225s left) kms_force_connector_basic (force-edid)
[806.390150] Subtest force-edid: SKIP (0.000s)
[806.458417] [144/156] (225s left) kms_hdr (static-swap)
[806.540754] Starting subtest: static-swap
[806.543102] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[806.547723] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[806.559589] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[806.563740] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[806.568198] Subtest static-swap: SKIP (0.002s)
[806.614922] [145/156] (224s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[806.707545] Starting subtest: 2x-long-flip-vs-cursor-atomic
[806.712089] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[806.867249] [146/156] (224s left) gem_mmap_offset (bad-flags)
[806.920339] Starting subtest: bad-flags
[806.922442] Subtest bad-flags: SUCCESS (0.000s)
[807.039620] [147/156] (224s left) kms_plane (plane-panning-top-left)
[807.112033] Starting subtest: plane-panning-top-left
[807.114022] Starting dynamic subtest: pipe-A
[808.858096] Dynamic subtest pipe-A: SUCCESS (1.745s)
[808.871040] Starting dynamic subtest: pipe-B
[811.308976] Dynamic subtest pipe-B: SUCCESS (2.451s)
[811.311350] Subtest plane-panning-top-left: SUCCESS (4.198s)
[812.258870] [148/156] (219s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[812.402454] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[812.406610] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[812.641040] [149/156] (219s left) gem_exec_basic (basic)
[812.740027] Starting subtest: basic
[812.742712] Starting dynamic subtest: rcs0-smem
[812.745193] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[812.760299] Starting dynamic subtest: bcs0-smem
[812.762508] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[812.773774] Starting dynamic subtest: vcs0-smem
[812.775958] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[812.787015] Starting dynamic subtest: vcs1-smem
[812.789188] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[812.800257] Starting dynamic subtest: vecs0-smem
[812.802598] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[812.813585] Starting dynamic subtest: ccs0-smem
[812.815816] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[812.818079] Subtest basic: SUCCESS (0.020s)
[814.422635] [150/156] (217s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[814.499652] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[814.504210] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[814.600531] [151/156] (217s left) kms_plane (pixel-format-linear-modifier)
[814.676566] Starting subtest: pixel-format-linear-modifier
[814.705752] Starting dynamic subtest: pipe-A-plane-0
[815.260932] Dynamic subtest pipe-A-plane-0: SUCCESS (0.555s)
[815.277617] Starting dynamic subtest: pipe-A-plane-3
[815.693979] Dynamic subtest pipe-A-plane-3: SUCCESS (0.431s)
[815.708111] Starting dynamic subtest: pipe-A-plane-5
[815.905022] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[816.996484] Starting dynamic subtest: pipe-B-plane-0
[817.541840] Dynamic subtest pipe-B-plane-0: SUCCESS (0.555s)
[817.553944] Starting dynamic subtest: pipe-B-plane-3
[817.963472] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s)
[817.975546] Starting dynamic subtest: pipe-B-plane-5
[818.174569] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[818.492324] Subtest pixel-format-linear-modifier: SUCCESS (3.816s)
[819.373920] [152/156] (212s left) gem_lmem_swapping (verify-ccs)
[819.418924] Subtest verify-ccs: SKIP (0.000s)
[819.460395] [153/156] (212s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[819.544267] Starting subtest: yf-tiled-64bpp-rotate-270
[819.548765] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[819.634995] [154/156] (212s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[819.708061] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[819.715662] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.008s)
[819.809927] [155/156] (212s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[819.911636] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[819.916251] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[820.058043] [156/156] (212s left) kms_flip (busy-flip)
[820.125532] Starting subtest: busy-flip
[820.127771] Starting dynamic subtest: A-eDP1
[821.789256] Dynamic subtest A-eDP1: SUCCESS (1.665s)
[821.803278] Starting dynamic subtest: B-eDP1
[823.528225] Dynamic subtest B-eDP1: SUCCESS (1.737s)
[823.541855] Starting dynamic subtest: C-eDP1
[825.248517] Dynamic subtest C-eDP1: SUCCESS (1.719s)
[825.265583] Starting dynamic subtest: D-eDP1
[826.982153] Dynamic subtest D-eDP1: SUCCESS (1.731s)
[826.987566] Subtest busy-flip: SUCCESS (6.864s)
[828.156369] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_readwrite
results: parsing output: 2/ for test: kms_getfb
results: parsing output: 3/ for test: sysfs_timeslice_duration
results: parsing output: 4/ for test: kms_chamelium_hpd
results: parsing output: 5/ for test: gem_eio
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: gem_basic
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_chamelium_frames
results: parsing output: 10/ for test: gem_ctx_persistence
results: parsing output: 11/ for test: drm_read
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_softpin
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_vblank
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_ctx_exec
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_plane_alpha_blend
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_pipe_b_c_ivb
results: parsing output: 35/ for test: kms_cdclk
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: api_intel_allocator
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: gem_sync
results: parsing output: 43/ for test: kms_async_flips
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_sequence
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: prime_busy
results: parsing output: 51/ for test: gem_eio
results: parsing output: 52/ for test: gem_mmap
results: parsing output: 53/ for test: kms_feature_discovery
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_content_protection
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_exec_flush
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: gem_partial_pwrite_pread
results: parsing output: 63/ for test: kms_setmode
results: parsing output: 64/ for test: i915_suspend
results: parsing output: 65/ for test: gem_exec_create
results: parsing output: 66/ for test: gem_ctx_shared
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: gem_watchdog
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: gen9_exec_parse
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_pipe_crc_basic
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: api_intel_bb
results: parsing output: 79/ for test: gem_lmem_swapping
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: gem_request_retire
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: gem_softpin
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: drm_mm
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: gem_mmap_offset
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_fbcon_fbt
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: kms_lease
results: parsing output: 106/ for test: vgem_basic
results: parsing output: 107/ for test: gem_ctx_param
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_prime
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_render_copy_redux
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_atomic_transition
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_color_pipeline
results: parsing output: 128/ for test: kms_dither
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_pm_dc
results: parsing output: 132/ for test: i915_hangman
results: parsing output: 133/ for test: kms_flip_scaled_crc
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gem_exec_params
results: parsing output: 136/ for test: kms_busy
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: i915_drm_fdinfo
results: parsing output: 139/ for test: gem_exec_flush
results: parsing output: 140/ for test: syncobj_timeline
results: parsing output: 141/ for test: prime_mmap
results: parsing output: 142/ for test: kms_force_connector_basic
results: parsing output: 143/ for test: kms_hdr
results: parsing output: 144/ for test: kms_cursor_legacy
results: parsing output: 145/ for test: gem_mmap_offset
results: parsing output: 146/ for test: kms_plane
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_exec_basic
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_plane
results: parsing output: 151/ for test: gem_lmem_swapping
results: parsing output: 152/ for test: kms_big_fb
results: parsing output: 153/ for test: kms_flip
results: parsing output: 154/ for test: kms_cursor_legacy
results: parsing output: 155/ for test: kms_flip
Done.