[57.555354] Initializing watchdogs [57.555402] /dev/watchdog0 [57.569081] [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.573705] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.576026] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.579489] [001/131] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [57.719480] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [57.723720] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [57.849216] [002/131] (960s left) gem_ctx_persistence (engines-queued) [57.911165] Starting subtest: engines-queued [57.913543] Starting dynamic subtest: rcs0 [58.023059] Dynamic subtest rcs0: SUCCESS (0.110s) [58.032596] Starting dynamic subtest: bcs0 [58.102088] Dynamic subtest bcs0: SUCCESS (0.077s) [58.110548] Starting dynamic subtest: vcs0 [59.893873] Dynamic subtest vcs0: SUCCESS (1.777s) [59.904174] Starting dynamic subtest: vcs1 [61.873459] Dynamic subtest vcs1: SUCCESS (1.968s) [61.883663] Starting dynamic subtest: vecs0 [63.860170] Dynamic subtest vecs0: SUCCESS (1.977s) [63.870101] Starting dynamic subtest: ccs0 [64.039660] Dynamic subtest ccs0: SUCCESS (0.180s) [64.042247] Subtest engines-queued: SUCCESS (6.095s) [64.202971] [003/131] (953s left) i915_hangman (hangcheck-unterminated) [64.275592] Starting subtest: hangcheck-unterminated [74.867903] Subtest hangcheck-unterminated: SUCCESS (10.573s) [75.046786] [004/131] (943s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [75.147262] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [75.149641] Starting dynamic subtest: pipe-A-default-mode [76.278884] Dynamic subtest pipe-A-default-mode: SKIP (1.127s) [76.283039] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.128s) [76.468215] [005/131] (941s left) tools_test (tools_test) [76.522678] Starting subtest: tools_test [76.569959] Subtest tools_test: SUCCESS (0.065s) [76.651159] [006/131] (941s left) perf (invalid-open-flags) [76.783615] Starting subtest: invalid-open-flags [76.785461] Subtest invalid-open-flags: SUCCESS (0.000s) [76.829634] [007/131] (941s left) i915_pm_rpm (debugfs-forcewake-user) [79.089763] Starting subtest: debugfs-forcewake-user [90.485732] Subtest debugfs-forcewake-user: SUCCESS (11.392s) [90.857722] [008/131] (927s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt) [90.959721] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt [95.106760] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.149s) [96.262639] [009/131] (922s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [96.357087] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [96.361261] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [96.475061] [010/131] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [96.565850] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [96.569942] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [96.675829] [011/131] (921s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [96.725907] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [96.833076] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s) [96.927899] [012/131] (921s left) gem_lmem_swapping (verify-random) [96.967647] Subtest verify-random: SKIP (0.000s) [97.002462] [013/131] (921s left) gem_exec_whisper (basic-queues-forked-all) [97.082417] Starting subtest: basic-queues-forked-all [117.149850] Subtest basic-queues-forked-all: SUCCESS (20.059s) [117.355341] [014/131] (901s left) kms_big_fb (x-tiled-32bpp-rotate-90) [117.458993] Starting subtest: x-tiled-32bpp-rotate-90 [117.479812] Subtest x-tiled-32bpp-rotate-90: SKIP (0.021s) [117.647476] [015/131] (900s left) kms_content_protection (lic-type-1) [117.788079] Starting subtest: lic-type-1 [117.792626] Subtest lic-type-1: SKIP (0.000s) [117.965818] [016/131] (900s left) gem_mmap_gtt (big-bo-tiledx) [118.031941] Subtest big-bo-tiledX: SKIP (0.000s) [118.091981] [017/131] (900s left) kms_prime (basic-modeset-hybrid) [118.171637] Subtest basic-modeset-hybrid: SKIP (0.000s) [118.305764] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true [118.308486] [018/131] (900s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [118.360064] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [118.423227] [019/131] (900s left) kms_cursor_crc (cursor-offscreen-256x256) [118.661755] Starting subtest: cursor-offscreen-256x256 [118.665905] Starting dynamic subtest: pipe-A-eDP-1 [120.612634] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.945s) [120.649914] Starting dynamic subtest: pipe-D-eDP-1 [123.250416] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.609s) [123.252802] Subtest cursor-offscreen-256x256: SUCCESS (4.588s) [124.133393] [020/131] (894s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [124.251203] Starting subtest: cursorA-vs-flipA-atomic-transitions [135.427093] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.172s) [136.263556] [021/131] (882s left) gem_eio (create) [136.515644] Starting subtest: create [136.848459] Subtest create: SUCCESS (0.333s) [137.044893] [022/131] (881s left) kms_flip (flip-vs-fences) [137.152438] Starting subtest: flip-vs-fences [137.156844] Subtest flip-vs-fences: SKIP (0.000s) [137.296111] [023/131] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [137.392879] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [137.396473] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [137.505644] [024/131] (881s left) gem_pxp (hw-rejects-pxp-context) [137.622672] Starting subtest: hw-rejects-pxp-context [137.626691] Subtest hw-rejects-pxp-context: SKIP (0.000s) [137.767303] [025/131] (881s left) kms_cursor_crc (cursor-size-hints) [137.886278] Starting subtest: cursor-size-hints [137.888267] Starting dynamic subtest: pipe-A-eDP-1 [138.494517] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s) [138.503621] Starting dynamic subtest: pipe-D-eDP-1 [139.813391] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s) [139.815694] Subtest cursor-size-hints: SUCCESS (1.926s) [140.633297] [026/131] (878s left) gen9_exec_parse (bb-start-far) [140.699646] Subtest bb-start-far: SKIP (0.000s) [140.789781] [027/131] (878s left) kms_vblank (ts-continuation-dpms-suspend) [140.885980] Starting subtest: ts-continuation-dpms-suspend [140.888259] Starting dynamic subtest: pipe-A-eDP-1 [157.604674] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.560s) [157.620008] Starting dynamic subtest: pipe-D-eDP-1 [175.617344] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.441s) [175.619728] Subtest ts-continuation-dpms-suspend: SUCCESS (8.005s) [176.477346] [028/131] (842s left) syncobj_timeline (etime-multi-wait-submitted) [176.541500] Starting subtest: etime-multi-wait-submitted [176.645837] Subtest etime-multi-wait-submitted: SUCCESS (0.103s) [176.752557] [029/131] (842s left) syncobj_timeline (invalid-wait-illegal-handle) [176.811692] Starting subtest: invalid-wait-illegal-handle [176.813846] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [176.928901] [030/131] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [177.021050] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [177.025648] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [177.146009] [031/131] (842s left) kms_psr (fbc-psr-primary-mmap-cpu) [177.240796] Starting subtest: fbc-psr-primary-mmap-cpu [177.243147] Starting dynamic subtest: eDP-1 [177.247537] Dynamic subtest eDP-1: SKIP (0.000s) [177.251939] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s) [177.340879] [032/131] (841s left) kms_lease (page-flip-implicit-plane) [177.440462] Starting subtest: page-flip-implicit-plane [177.442746] Starting dynamic subtest: pipe-A-eDP-1 [177.948734] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.491s) [177.960692] Starting dynamic subtest: pipe-B-eDP-1 [179.051446] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.078s) [179.062076] Starting dynamic subtest: pipe-C-eDP-1 [180.201199] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s) [180.217900] Starting dynamic subtest: pipe-D-eDP-1 [181.356527] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s) [181.358720] Subtest page-flip-implicit-plane: SUCCESS (3.837s) [182.231527] [033/131] (837s left) gem_exec_create (madvise) [182.299162] Starting subtest: madvise [182.301504] Starting dynamic subtest: smem [203.629437] Dynamic subtest smem: SUCCESS (21.225s) [203.632001] Subtest madvise: SUCCESS (21.226s) [204.555473] [034/131] (814s left) gem_create (create-ext-placement-all) [204.733829] Starting subtest: create-ext-placement-all [204.736728] Subtest create-ext-placement-all: SUCCESS (0.000s) [204.880728] [035/131] (814s left) kms_chamelium_frames (dp-crc-multiple) [205.286749] Subtest dp-crc-multiple: SKIP (0.000s) [206.122266] [036/131] (813s left) kms_big_fb (4-tiled-addfb) [206.224828] Starting subtest: 4-tiled-addfb [206.227118] Subtest 4-tiled-addfb: SUCCESS (0.000s) [206.371346] [037/131] (813s left) perf_pmu (idle) [206.417441] Starting subtest: idle [206.419713] Starting dynamic subtest: rcs0 [206.995223] Dynamic subtest rcs0: SUCCESS (0.574s) [207.006469] Starting dynamic subtest: bcs0 [207.514204] Dynamic subtest bcs0: SUCCESS (0.520s) [207.525968] Starting dynamic subtest: vcs0 [208.032275] Dynamic subtest vcs0: SUCCESS (0.517s) [208.042774] Starting dynamic subtest: vcs1 [208.548718] Dynamic subtest vcs1: SUCCESS (0.515s) [208.559606] Starting dynamic subtest: vecs0 [209.070812] Dynamic subtest vecs0: SUCCESS (0.520s) [209.082345] Starting dynamic subtest: ccs0 [209.599902] Dynamic subtest ccs0: SUCCESS (0.527s) [209.602695] Subtest idle: SUCCESS (3.185s) [209.722687] [038/131] (809s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [210.312812] Starting subtest: syncobj-backward-timeline-chain-engines [210.467551] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.155s) [211.714543] [039/131] (807s left) prime_vgem (fence-read-hang) [211.796870] Subtest fence-read-hang: SKIP (0.000s) [211.947229] [040/131] (807s left) kms_big_fb (y-tiled-addfb-size-overflow) [212.058665] Starting subtest: y-tiled-addfb-size-overflow [212.062601] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [212.175256] [041/131] (807s left) gem_ppgtt (blt-vs-render-ctxn) [212.239451] Starting subtest: blt-vs-render-ctxN [245.335184] Subtest blt-vs-render-ctxN: SUCCESS (33.087s) [245.513212] [042/131] (774s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite) [245.667720] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite [252.478585] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.811s) [252.631237] [043/131] (767s left) kms_dither (fb-8bpc-vs-panel-6bpc) [252.733285] Starting subtest: fb-8bpc-vs-panel-6bpc [252.735534] Starting dynamic subtest: pipe-A-eDP-1 [254.105814] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.370s) [254.108067] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.372s) [254.995496] [044/131] (764s left) gem_pwrite_snooped [255.128527] [045/131] (764s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [255.225368] Starting subtest: extended-modeset-hang-oldfb-with-reset [255.227743] Starting dynamic subtest: pipe-A [267.259287] Dynamic subtest pipe-A: SUCCESS (12.027s) [267.277521] Starting dynamic subtest: pipe-D [279.528993] Dynamic subtest pipe-D: SUCCESS (12.272s) [279.531410] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.303s) [280.348476] [046/131] (739s left) gem_userptr_blits (probe) [280.426239] Starting subtest: probe [280.498388] Subtest probe: SUCCESS (0.072s) [280.665330] [047/131] (739s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [280.774555] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [287.968327] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.199s) [288.136346] [048/131] (731s left) kms_draw_crc (draw-method-render) [288.229031] Starting subtest: draw-method-render [288.230932] Starting dynamic subtest: xrgb8888-untiled [288.448604] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s) [288.458877] Starting dynamic subtest: rgb565-untiled [288.670667] Dynamic subtest rgb565-untiled: SUCCESS (0.221s) [288.680599] Starting dynamic subtest: xrgb2101010-untiled [288.882165] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s) [288.892169] Starting dynamic subtest: xbgr16161616f-untiled [289.114746] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s) [289.124692] Starting dynamic subtest: xrgb8888-xtiled [289.236925] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s) [289.246030] Starting dynamic subtest: rgb565-xtiled [289.347837] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s) [289.357692] Starting dynamic subtest: xrgb2101010-xtiled [289.470454] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [289.482168] Starting dynamic subtest: xbgr16161616f-xtiled [289.581099] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s) [289.590862] Starting dynamic subtest: xrgb8888-4tiled [289.703458] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s) [289.713581] Starting dynamic subtest: rgb565-4tiled [289.814766] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s) [289.828936] Starting dynamic subtest: xrgb2101010-4tiled [289.925452] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s) [289.934853] Starting dynamic subtest: xbgr16161616f-4tiled [290.036799] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s) [290.038631] Subtest draw-method-render: SUCCESS (1.811s) [290.157112] [049/131] (729s left) syncobj_timeline (single-wait-all-for-submit-signaled) [290.227140] Starting subtest: single-wait-all-for-submit-signaled [290.229150] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [290.359713] [050/131] (729s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [290.471472] Starting subtest: fbc-rgb565-draw-mmap-gtt [290.475107] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [290.605951] [051/131] (729s left) kms_psr (fbc-pr-dpms) [290.704410] Starting subtest: fbc-pr-dpms [290.707815] Subtest fbc-pr-dpms: SKIP (0.000s) [290.803175] [052/131] (729s left) syncobj_wait (multi-wait-all-for-submit-signaled) [290.873945] Starting subtest: multi-wait-all-for-submit-signaled [290.876099] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [291.012450] [053/131] (729s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [291.135484] Starting subtest: short-flip-after-cursor-toggle [292.081634] Subtest short-flip-after-cursor-toggle: SUCCESS (0.946s) [292.904419] [054/131] (727s left) perf_pmu (busy-accuracy-98) [292.942994] Starting subtest: busy-accuracy-98 [292.944979] Starting dynamic subtest: rcs0 [295.985546] Dynamic subtest rcs0: SUCCESS (3.041s) [295.997204] Starting dynamic subtest: bcs0 [299.039484] Dynamic subtest bcs0: SUCCESS (3.053s) [299.051514] Starting dynamic subtest: vcs0 [302.082669] Dynamic subtest vcs0: SUCCESS (3.041s) [302.094667] Starting dynamic subtest: vcs1 [305.122170] Dynamic subtest vcs1: SUCCESS (3.038s) [305.133021] Starting dynamic subtest: vecs0 [308.163058] Dynamic subtest vecs0: SUCCESS (3.039s) [308.174162] Starting dynamic subtest: ccs0 [311.217149] Dynamic subtest ccs0: SUCCESS (3.052s) [311.219668] Subtest busy-accuracy-98: SUCCESS (18.277s) [311.360613] [055/131] (708s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [311.460144] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [311.464039] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [311.596720] [056/131] (708s left) gem_exec_parallel (basic) [311.656718] Starting subtest: basic [311.659128] Starting dynamic subtest: rcs0 [313.111845] Dynamic subtest rcs0: SUCCESS (1.455s) [313.124420] Starting dynamic subtest: bcs0 [314.572710] Dynamic subtest bcs0: SUCCESS (1.459s) [314.585157] Starting dynamic subtest: vcs0 [316.522422] Dynamic subtest vcs0: SUCCESS (1.946s) [316.534941] Starting dynamic subtest: vcs1 [318.571689] Dynamic subtest vcs1: SUCCESS (2.047s) [318.584371] Starting dynamic subtest: vecs0 [320.555452] Dynamic subtest vecs0: SUCCESS (1.981s) [320.567843] Starting dynamic subtest: ccs0 [322.078735] Dynamic subtest ccs0: SUCCESS (1.522s) [322.081346] Subtest basic: SUCCESS (10.422s) [322.288744] [057/131] (698s left) i915_drm_fdinfo (memory-info-resident) [322.334638] Starting subtest: memory-info-resident [322.337164] Starting dynamic subtest: smem0 [325.414057] Dynamic subtest smem0: SUCCESS (3.081s) [325.416356] Subtest memory-info-resident: SUCCESS (3.082s) [325.511832] [058/131] (694s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [325.603378] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [325.605368] Starting dynamic subtest: pipe-A-default-mode [325.890308] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [325.894964] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.286s) [326.723940] [059/131] (693s left) gem_basic (multigpu-create-close) [326.788185] Starting subtest: multigpu-create-close [326.792726] Subtest multigpu-create-close: SKIP (0.000s) [326.934322] [060/131] (693s left) kms_vblank (accuracy-idle) [327.021904] Starting subtest: accuracy-idle [327.023762] Starting dynamic subtest: pipe-A-eDP-1 [328.775353] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s) [328.790491] Starting dynamic subtest: pipe-D-eDP-1 [331.248340] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.470s) [331.250270] Subtest accuracy-idle: SUCCESS (4.226s) [332.086648] [061/131] (688s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [332.207844] Starting subtest: cursorB-vs-flipA-atomic [332.212419] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s) [332.377896] [062/131] (688s left) gem_exec_balancer (fairslice) [332.449314] Starting subtest: fairslice [335.323295] Subtest fairslice: SUCCESS (2.875s) [336.612218] [063/131] (683s left) gem_mmap (bad-object) [336.681317] Subtest bad-object: SKIP (0.000s) [336.752189] [064/131] (683s left) i915_selftest (mock) [339.667588] Starting subtest: mock [339.673564] Starting dynamic subtest: sanitycheck [340.423240] Dynamic subtest sanitycheck: SUCCESS (0.755s) [340.433535] Starting dynamic subtest: shmem [341.135250] Dynamic subtest shmem: SUCCESS (0.710s) [341.145716] Starting dynamic subtest: fence [348.697022] Dynamic subtest fence: SUCCESS (7.558s) [348.706184] Starting dynamic subtest: scatterlist [350.436286] Dynamic subtest scatterlist: SUCCESS (1.737s) [350.446552] Starting dynamic subtest: syncmap [353.770450] Dynamic subtest syncmap: SUCCESS (3.332s) [353.786658] Starting dynamic subtest: uncore [354.528167] Dynamic subtest uncore: SUCCESS (0.756s) [354.538212] Starting dynamic subtest: ring [355.278044] Dynamic subtest ring: SUCCESS (0.748s) [355.288350] Starting dynamic subtest: engine [355.954016] Dynamic subtest engine: SUCCESS (0.674s) [355.964036] Starting dynamic subtest: timelines [359.815792] Dynamic subtest timelines: SUCCESS (3.858s) [359.826935] Starting dynamic subtest: requests [363.448561] Dynamic subtest requests: SUCCESS (3.628s) [363.458419] Starting dynamic subtest: objects [364.333455] Dynamic subtest objects: SUCCESS (0.883s) [364.343067] Starting dynamic subtest: phys [365.188379] Dynamic subtest phys: SUCCESS (0.853s) [365.197700] Starting dynamic subtest: dmabuf [366.020283] Dynamic subtest dmabuf: SUCCESS (0.830s) [366.030088] Starting dynamic subtest: vma [371.333050] Dynamic subtest vma: SUCCESS (5.309s) [371.341249] Starting dynamic subtest: evict [372.730691] Dynamic subtest evict: SUCCESS (1.395s) [372.740358] Starting dynamic subtest: gtt [376.463259] Dynamic subtest gtt: SUCCESS (3.730s) [376.473036] Starting dynamic subtest: hugepages [377.405227] Dynamic subtest hugepages: SUCCESS (0.940s) [377.415389] Starting dynamic subtest: memory_region [380.049931] Dynamic subtest memory_region: SUCCESS (2.642s) [380.052647] Subtest mock: SUCCESS (40.375s) [380.080611] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [380.081286] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [380.084376] [065/131] (640s left) kms_pm_rpm (cursor) [386.344602] Starting subtest: cursor [386.349367] Subtest cursor: SKIP (0.000s) [387.089468] [FACT kms_pm_rpm (cursor)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [387.090629] [FACT kms_pm_rpm (cursor)] new: kernel.kmod_is_loaded.i915: true [387.094502] [066/131] (633s left) syncobj_wait (wait-for-submit-snapshot) [387.165020] Starting subtest: wait-for-submit-snapshot [387.243920] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [387.343217] [067/131] (633s left) kms_psr (fbc-psr2-basic) [387.440315] Starting subtest: fbc-psr2-basic [387.442658] Starting dynamic subtest: eDP-1 [387.447117] Dynamic subtest eDP-1: SKIP (0.000s) [387.451591] Subtest fbc-psr2-basic: SKIP (0.001s) [387.539233] [068/131] (633s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [387.614208] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [387.616508] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [387.748982] [069/131] (633s left) gem_gtt_cpu_tlb [387.877960] [070/131] (633s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [387.970047] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [387.972159] Starting dynamic subtest: pipe-A-eDP-1 [387.992061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [388.002471] Starting dynamic subtest: pipe-B-eDP-1 [388.017852] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [388.025515] Starting dynamic subtest: pipe-C-eDP-1 [388.041561] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [388.049315] Starting dynamic subtest: pipe-D-eDP-1 [388.065275] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [388.066846] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [390.162258] [071/131] (630s left) sysfs_heartbeat_interval (idempotent) [390.227625] Starting subtest: idempotent [390.230044] Starting dynamic subtest: vecs0 [390.232462] Dynamic subtest vecs0: SUCCESS (0.001s) [390.243072] Starting dynamic subtest: ccs0 [390.245651] Dynamic subtest ccs0: SUCCESS (0.001s) [390.258566] Starting dynamic subtest: vcs0 [390.260441] Dynamic subtest vcs0: SUCCESS (0.001s) [390.268474] Starting dynamic subtest: bcs0 [390.270296] Dynamic subtest bcs0: SUCCESS (0.003s) [390.278752] Starting dynamic subtest: rcs0 [390.280570] Dynamic subtest rcs0: SUCCESS (0.002s) [390.288551] Starting dynamic subtest: vcs1 [390.290435] Dynamic subtest vcs1: SUCCESS (0.001s) [390.292365] Subtest idempotent: SUCCESS (0.019s) [390.386466] [072/131] (630s left) kms_setmode (invalid-clone-single-crtc) [390.449758] Starting subtest: invalid-clone-single-crtc [390.456091] Subtest invalid-clone-single-crtc: SKIP (0.000s) [390.570025] [073/131] (630s left) kms_force_connector_basic (force-edid) [390.646870] Starting subtest: force-edid [391.010326] Subtest force-edid: SUCCESS (0.366s) [391.174120] [074/131] (629s left) gem_exec_schedule (fairslice) [391.246215] Starting subtest: fairslice [391.247835] Starting dynamic subtest: rcs0 [393.263185] Dynamic subtest rcs0: SUCCESS (2.019s) [393.272253] Starting dynamic subtest: bcs0 [395.281996] Dynamic subtest bcs0: SUCCESS (2.017s) [395.293469] Starting dynamic subtest: vcs0 [397.304052] Dynamic subtest vcs0: SUCCESS (2.018s) [397.313539] Starting dynamic subtest: vcs1 [399.318405] Dynamic subtest vcs1: SUCCESS (2.015s) [399.328732] Starting dynamic subtest: vecs0 [401.339018] Dynamic subtest vecs0: SUCCESS (2.017s) [401.348665] Starting dynamic subtest: ccs0 [403.354814] Dynamic subtest ccs0: SUCCESS (2.018s) [403.356673] Subtest fairslice: SUCCESS (12.111s) [403.677507] [075/131] (617s left) syncobj_timeline (reset-unsignaled) [403.738311] Starting subtest: reset-unsignaled [403.740587] Subtest reset-unsignaled: SUCCESS (0.000s) [403.873798] [076/131] (617s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [403.983951] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [410.980345] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.998s) [411.131977] [077/131] (610s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [411.247346] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [411.377790] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.132s) [411.530260] [078/131] (609s left) gem_mmap_wc (read-write) [411.590576] Subtest read-write: SKIP (0.000s) [411.657335] [079/131] (609s left) perf (buffer-fill) [411.797464] Starting subtest: buffer-fill [411.799680] Starting dynamic subtest: 0-rcs0 [414.043343] Dynamic subtest 0-rcs0: SUCCESS (2.244s) [414.053211] Starting dynamic subtest: 1-vcs0 [418.441052] Dynamic subtest 1-vcs0: SUCCESS (4.396s) [418.443757] Subtest buffer-fill: SUCCESS (6.643s) [418.482301] [080/131] (602s left) gem_userptr_blits (stress-mm-invalidate-close) [418.544640] Starting subtest: stress-mm-invalidate-close [420.693432] Subtest stress-mm-invalidate-close: SUCCESS (2.148s) [420.909768] [081/131] (600s left) gem_exec_reloc (basic-write-gtt-noreloc) [420.985736] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [421.080758] [082/131] (600s left) gem_exec_store (cachelines) [421.140742] Starting subtest: cachelines [421.143029] Starting dynamic subtest: rcs0 [421.259863] Dynamic subtest rcs0: SUCCESS (0.122s) [421.271683] Starting dynamic subtest: bcs0 [421.332634] Dynamic subtest bcs0: SUCCESS (0.071s) [421.343553] Starting dynamic subtest: vcs0 [421.399192] Dynamic subtest vcs0: SUCCESS (0.064s) [421.410654] Starting dynamic subtest: vcs1 [421.461758] Dynamic subtest vcs1: SUCCESS (0.061s) [421.473559] Starting dynamic subtest: vecs0 [421.526082] Dynamic subtest vecs0: SUCCESS (0.062s) [421.537083] Starting dynamic subtest: ccs0 [421.593390] Dynamic subtest ccs0: SUCCESS (0.066s) [421.595666] Subtest cachelines: SUCCESS (0.457s) [421.803879] [083/131] (599s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [421.908056] Starting subtest: plane-primary-toggle-with-vblank-wait [421.910415] Starting dynamic subtest: pipe-A-eDP-1 [422.082869] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.176s) [422.387341] Starting dynamic subtest: pipe-B-eDP-1 [423.328386] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.949s) [423.627955] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.721s) [424.479726] [084/131] (597s left) gem_exec_flush (basic-batch-kernel-default-wb) [424.548606] Starting subtest: basic-batch-kernel-default-wb [431.060030] Subtest basic-batch-kernel-default-wb: SUCCESS (6.512s) [431.282140] [085/131] (590s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [431.384615] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [435.794556] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.415s) [436.998403] [086/131] (584s left) kms_cursor_crc (cursor-rapid-movement-256x85) [437.250384] Starting subtest: cursor-rapid-movement-256x85 [437.296718] Subtest cursor-rapid-movement-256x85: SKIP (0.040s) [437.503706] [087/131] (584s left) gem_mmap_gtt (isolation) [437.562338] Subtest isolation: SKIP (0.000s) [437.626743] [088/131] (584s left) kms_psr (psr-cursor-mmap-cpu) [437.722050] Starting subtest: psr-cursor-mmap-cpu [437.724236] Starting dynamic subtest: eDP-1 [439.421619] Dynamic subtest eDP-1: SUCCESS (1.700s) [439.423805] Subtest psr-cursor-mmap-cpu: SUCCESS (1.701s) [440.280089] [089/131] (581s left) kms_atomic_transition (modeset-transition) [440.378126] Starting subtest: modeset-transition [440.380279] Starting dynamic subtest: 1x-outputs [451.224766] Dynamic subtest 1x-outputs: SUCCESS (10.848s) [451.227206] Subtest modeset-transition: SUCCESS (10.849s) [452.081659] [090/131] (569s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [452.183155] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [452.185311] Starting dynamic subtest: pipe-A-eDP-1 [452.326057] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.134s) [452.337416] Starting dynamic subtest: pipe-B-eDP-1 [452.357907] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [452.369242] Starting dynamic subtest: pipe-C-eDP-1 [452.388730] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [452.397024] Starting dynamic subtest: pipe-D-eDP-1 [452.416751] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [452.419083] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.143s) [454.586098] [091/131] (567s left) kms_pipe_crc_basic (read-crc) [454.681045] Starting subtest: read-crc [454.683298] Starting dynamic subtest: pipe-A-eDP-1 [455.379368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s) [455.390507] Starting dynamic subtest: pipe-B-eDP-1 [456.811021] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.429s) [456.820268] Starting dynamic subtest: pipe-C-eDP-1 [458.147048] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.335s) [458.157228] Starting dynamic subtest: pipe-D-eDP-1 [459.459463] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.311s) [459.461781] Subtest read-crc: SUCCESS (4.780s) [460.275950] [092/131] (561s left) api_intel_bb (object-noreloc-keep-cache-simple) [460.325798] Starting subtest: object-noreloc-keep-cache-simple [460.328311] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s) [460.490301] [093/131] (561s left) gem_exec_schedule (preempt-hang) [460.669996] Starting subtest: preempt-hang [460.672318] Starting dynamic subtest: rcs0 [460.907500] Dynamic subtest rcs0: SUCCESS (0.239s) [460.921787] Starting dynamic subtest: bcs0 [461.136486] Dynamic subtest bcs0: SUCCESS (0.229s) [461.147594] Starting dynamic subtest: vcs0 [461.354605] Dynamic subtest vcs0: SUCCESS (0.217s) [461.364554] Starting dynamic subtest: vcs1 [461.572669] Dynamic subtest vcs1: SUCCESS (0.217s) [461.582291] Starting dynamic subtest: vecs0 [461.794894] Dynamic subtest vecs0: SUCCESS (0.221s) [461.806322] Starting dynamic subtest: ccs0 [462.022442] Dynamic subtest ccs0: SUCCESS (0.227s) [462.024647] Subtest preempt-hang: SUCCESS (1.356s) [462.700916] [094/131] (559s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [462.832259] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [462.836765] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [463.009218] [095/131] (558s left) kms_scaling_modes (scaling-mode-full) [463.109305] Starting subtest: scaling-mode-full [463.111628] Starting dynamic subtest: pipe-A-eDP-1 [463.201390] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.092s) [463.211530] Starting dynamic subtest: pipe-B-eDP-1 [464.352620] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.150s) [464.368684] Starting dynamic subtest: pipe-C-eDP-1 [465.524736] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.169s) [465.534366] Starting dynamic subtest: pipe-D-eDP-1 [466.627671] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.101s) [466.630053] Subtest scaling-mode-full: SUCCESS (3.519s) [467.875364] [096/131] (554s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75) [467.972863] Starting subtest: planes-unity-scaling-downscale-factor-0-75 [467.975257] Starting dynamic subtest: pipe-A [468.034016] Dynamic subtest pipe-A: SUCCESS (0.064s) [468.046251] Starting dynamic subtest: pipe-B [469.152570] Dynamic subtest pipe-B: SUCCESS (1.117s) [469.166136] Starting dynamic subtest: pipe-C [470.346180] Dynamic subtest pipe-C: SUCCESS (1.191s) [470.355822] Starting dynamic subtest: pipe-D [471.436404] Dynamic subtest pipe-D: SUCCESS (1.089s) [471.438822] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.468s) [472.684450] [097/131] (549s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [472.787367] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [472.789793] Starting dynamic subtest: pipe-A [473.136198] Dynamic subtest pipe-A: SUCCESS (0.351s) [473.145378] Starting dynamic subtest: pipe-B [474.551495] Dynamic subtest pipe-B: SUCCESS (1.414s) [474.561675] Starting dynamic subtest: pipe-C [475.927359] Dynamic subtest pipe-C: SUCCESS (1.374s) [475.935862] Starting dynamic subtest: pipe-D [477.326386] Dynamic subtest pipe-D: SUCCESS (1.398s) [477.328799] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.541s) [478.582531] [098/131] (543s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [478.678673] Starting subtest: fbcpsr-slowdraw [503.561196] Subtest fbcpsr-slowdraw: SUCCESS (24.882s) [503.728968] [099/131] (518s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [503.822920] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [503.825132] Starting dynamic subtest: pipe-A-eDP-1 [503.833725] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [503.843054] Starting dynamic subtest: pipe-B-eDP-1 [503.851607] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [503.860534] Starting dynamic subtest: pipe-C-eDP-1 [503.868576] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [503.876582] Starting dynamic subtest: pipe-D-eDP-1 [503.884699] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [503.888615] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [506.076829] [100/131] (516s left) kms_addfb_basic (too-high) [506.176696] Starting subtest: too-high [506.178873] Subtest too-high: SUCCESS (0.000s) [506.315482] [101/131] (515s left) prime_vgem (fence-wait) [506.402581] Starting subtest: fence-wait [506.404595] Starting dynamic subtest: rcs0 [507.458646] Dynamic subtest rcs0: SUCCESS (1.055s) [507.470063] Starting dynamic subtest: bcs0 [508.538043] Dynamic subtest bcs0: SUCCESS (1.076s) [508.549753] Starting dynamic subtest: vcs0 [509.576757] Dynamic subtest vcs0: SUCCESS (1.037s) [509.586924] Starting dynamic subtest: vcs1 [510.622202] Dynamic subtest vcs1: SUCCESS (1.043s) [510.632715] Starting dynamic subtest: vecs0 [511.662072] Dynamic subtest vecs0: SUCCESS (1.037s) [511.673009] Starting dynamic subtest: ccs0 [512.735335] Dynamic subtest ccs0: SUCCESS (1.040s) [512.739787] Subtest fence-wait: SUCCESS (6.302s) [512.872503] [102/131] (509s left) kms_invalid_mode (bad-hsync-start) [512.975071] Starting subtest: bad-hsync-start [512.977225] Starting dynamic subtest: pipe-A-eDP-1 [513.255687] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s) [513.265851] Starting dynamic subtest: pipe-B-eDP-1 [513.268451] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [513.277140] Starting dynamic subtest: pipe-C-eDP-1 [513.279648] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [513.288017] Starting dynamic subtest: pipe-D-eDP-1 [513.290185] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [513.292116] Subtest bad-hsync-start: SUCCESS (0.288s) [514.093736] [103/131] (508s left) kms_big_fb (linear-8bpp-rotate-90) [514.203073] Starting subtest: linear-8bpp-rotate-90 [514.225264] Subtest linear-8bpp-rotate-90: SKIP (0.021s) [514.387409] [104/131] (507s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area) [519.440651] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area [519.445431] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s) [520.289679] [105/131] (502s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [520.394590] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [526.565921] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.173s) [527.797379] [106/131] (494s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf) [532.821966] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf [532.824423] Starting dynamic subtest: pipe-A-eDP-1 [544.225830] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.402s) [544.240400] Starting dynamic subtest: pipe-B-eDP-1 [555.626533] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.395s) [555.628876] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.802s) [556.473999] [107/131] (465s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [556.593046] Starting subtest: yf-tiled-32bpp-rotate-0 [556.597579] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [556.730159] [108/131] (465s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render) [556.826403] Starting subtest: fbcpsr-rgb565-draw-render [563.716367] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.891s) [563.877185] [109/131] (458s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [563.993318] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [563.997794] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [564.133728] [110/131] (458s left) kms_setmode (invalid-clone-single-crtc-stealing) [564.193716] Starting subtest: invalid-clone-single-crtc-stealing [564.200349] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s) [564.334070] [111/131] (458s left) kms_flip (2x-absolute-wf_vblank-interruptible) [564.453325] Starting subtest: 2x-absolute-wf_vblank-interruptible [564.466289] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s) [564.569706] [112/131] (458s left) gem_exec_params (sol-reset-invalid) [564.648573] Starting subtest: sol-reset-invalid [564.653750] Subtest sol-reset-invalid: SUCCESS (0.003s) [566.642066] [113/131] (456s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [566.739155] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [566.741451] Starting dynamic subtest: pipe-A-eDP-1 [566.761306] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.019s) [566.771298] Starting dynamic subtest: pipe-B-eDP-1 [566.791247] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s) [566.800205] Starting dynamic subtest: pipe-C-eDP-1 [566.820152] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s) [566.828901] Starting dynamic subtest: pipe-D-eDP-1 [566.849147] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s) [566.851228] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s) [569.089118] [114/131] (453s left) gem_softpin (allocator-nopin) [569.150294] Starting subtest: allocator-nopin [569.259847] Subtest allocator-nopin: SUCCESS (0.108s) [569.412347] [115/131] (453s left) kms_chamelium_color (ctm-blue-to-red) [569.516114] Subtest ctm-blue-to-red: SKIP (0.000s) [569.559010] [116/131] (453s left) kms_addfb_basic (legacy-format) [569.618166] Starting subtest: legacy-format [569.644274] Subtest legacy-format: SUCCESS (0.024s) [569.815498] [117/131] (453s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [569.916637] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [574.157808] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.243s) [575.295392] [118/131] (447s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [575.401237] Starting subtest: coverage-vs-premult-vs-constant [575.687774] Starting dynamic subtest: pipe-A-eDP-1 [576.242029] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s) [576.252015] Starting dynamic subtest: pipe-D-eDP-1 [577.542323] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.298s) [577.544793] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.142s) [578.384105] [119/131] (444s left) gem_exec_fence (basic-await) [578.563920] Starting subtest: basic-await [578.566505] Starting dynamic subtest: rcs0 [578.640197] Dynamic subtest rcs0: SUCCESS (0.076s) [578.651131] Starting dynamic subtest: bcs0 [578.711233] Dynamic subtest bcs0: SUCCESS (0.070s) [578.721673] Starting dynamic subtest: vcs0 [578.785268] Dynamic subtest vcs0: SUCCESS (0.072s) [578.797529] Starting dynamic subtest: vcs1 [578.857003] Dynamic subtest vcs1: SUCCESS (0.070s) [578.869014] Starting dynamic subtest: vecs0 [578.929844] Dynamic subtest vecs0: SUCCESS (0.071s) [578.942063] Starting dynamic subtest: ccs0 [579.003736] Dynamic subtest ccs0: SUCCESS (0.072s) [579.006721] Subtest basic-await: SUCCESS (0.440s) [580.650763] [120/131] (442s left) gem_userptr_blits (forbidden-operations) [580.721383] Starting subtest: forbidden-operations [580.725805] Subtest forbidden-operations: SKIP (0.000s) [580.892084] [121/131] (442s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs) [580.967201] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs [580.971599] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s) [581.177348] [122/131] (441s left) prime_self_import (basic-with_one_bo_two_files) [581.210509] Starting subtest: basic-with_one_bo_two_files [581.232435] Subtest basic-with_one_bo_two_files: SUCCESS (0.022s) [581.371839] [123/131] (441s left) gem_exec_schedule (reorder-wide) [581.561394] Subtest reorder-wide: SKIP (0.000s) [581.765599] [124/131] (441s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [581.862195] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [581.866406] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [581.981774] [125/131] (441s left) gem_ctx_param (invalid-get-no-zeromap) [582.040757] Starting subtest: invalid-get-no-zeromap [582.043000] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [582.179646] [126/131] (441s left) kms_psr (pr-suspend) [582.273916] Starting subtest: pr-suspend [582.277910] Subtest pr-suspend: SKIP (0.000s) [582.368764] [127/131] (440s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [582.441181] Subtest writes-after-reads-snoop: SKIP (0.000s) [582.521701] [128/131] (440s left) core_setmaster (master-drop-set-root) [582.606839] Starting subtest: master-drop-set-root [582.619244] Subtest master-drop-set-root: SUCCESS (0.013s) [582.665017] [129/131] (440s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [582.728468] Starting subtest: invalid-multi-wait-unsubmitted-signaled [582.730352] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [582.865949] [130/131] (440s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [583.240730] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [584.045814] [131/131] (439s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [584.103122] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [584.172211] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: gem_ctx_persistence results: parsing output: 2/ for test: i915_hangman results: parsing output: 3/ for test: kms_flip_scaled_crc results: parsing output: 4/ for test: tools_test results: parsing output: 5/ for test: perf results: parsing output: 6/ for test: i915_pm_rpm results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_big_fb results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: syncobj_timeline results: parsing output: 11/ for test: gem_lmem_swapping results: parsing output: 12/ for test: gem_exec_whisper results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: kms_content_protection results: parsing output: 15/ for test: gem_mmap_gtt results: parsing output: 16/ for test: kms_prime results: parsing output: 17/ for test: gem_mmap_wc results: parsing output: 18/ for test: kms_cursor_crc results: parsing output: 19/ for test: kms_cursor_legacy results: parsing output: 20/ for test: gem_eio results: parsing output: 21/ for test: kms_flip results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: gem_pxp results: parsing output: 24/ for test: kms_cursor_crc results: parsing output: 25/ for test: gen9_exec_parse results: parsing output: 26/ for test: kms_vblank results: parsing output: 27/ for test: syncobj_timeline results: parsing output: 28/ for test: syncobj_timeline results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_psr results: parsing output: 31/ for test: kms_lease results: parsing output: 32/ for test: gem_exec_create results: parsing output: 33/ for test: gem_create results: parsing output: 34/ for test: kms_chamelium_frames results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: perf_pmu results: parsing output: 37/ for test: gem_exec_fence results: parsing output: 38/ for test: prime_vgem results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: gem_ppgtt results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_dither results: parsing output: 43/ for test: gem_pwrite_snooped results: parsing output: 44/ for test: kms_busy results: parsing output: 45/ for test: gem_userptr_blits results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_draw_crc results: parsing output: 48/ for test: syncobj_timeline results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: syncobj_wait results: parsing output: 52/ for test: kms_cursor_legacy results: parsing output: 53/ for test: perf_pmu results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: gem_exec_parallel results: parsing output: 56/ for test: i915_drm_fdinfo results: parsing output: 57/ for test: kms_flip_scaled_crc results: parsing output: 58/ for test: gem_basic results: parsing output: 59/ for test: kms_vblank results: parsing output: 60/ for test: kms_cursor_legacy results: parsing output: 61/ for test: gem_exec_balancer results: parsing output: 62/ for test: gem_mmap results: parsing output: 63/ for test: i915_selftest results: parsing output: 64/ for test: kms_pm_rpm results: parsing output: 65/ for test: syncobj_wait results: parsing output: 66/ for test: kms_psr results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: gem_gtt_cpu_tlb results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: sysfs_heartbeat_interval results: parsing output: 71/ for test: kms_setmode results: parsing output: 72/ for test: kms_force_connector_basic results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: syncobj_timeline results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: gem_pxp results: parsing output: 77/ for test: gem_mmap_wc results: parsing output: 78/ for test: perf results: parsing output: 79/ for test: gem_userptr_blits results: parsing output: 80/ for test: gem_exec_reloc results: parsing output: 81/ for test: gem_exec_store results: parsing output: 82/ for test: kms_atomic_transition results: parsing output: 83/ for test: gem_exec_flush results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_cursor_crc results: parsing output: 86/ for test: gem_mmap_gtt results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: kms_atomic_transition results: parsing output: 89/ for test: kms_ccs results: parsing output: 90/ for test: kms_pipe_crc_basic results: parsing output: 91/ for test: api_intel_bb results: parsing output: 92/ for test: gem_exec_schedule results: parsing output: 93/ for test: kms_cursor_legacy results: parsing output: 94/ for test: kms_scaling_modes results: parsing output: 95/ for test: kms_plane_scaling results: parsing output: 96/ for test: kms_plane_scaling results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_ccs results: parsing output: 99/ for test: kms_addfb_basic results: parsing output: 100/ for test: prime_vgem results: parsing output: 101/ for test: kms_invalid_mode results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: kms_psr2_sf results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_psr2_sf results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_setmode results: parsing output: 110/ for test: kms_flip results: parsing output: 111/ for test: gem_exec_params results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: gem_softpin results: parsing output: 114/ for test: kms_chamelium_color results: parsing output: 115/ for test: kms_addfb_basic results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_plane_alpha_blend results: parsing output: 118/ for test: gem_exec_fence results: parsing output: 119/ for test: gem_userptr_blits results: parsing output: 120/ for test: gem_render_copy results: parsing output: 121/ for test: prime_self_import results: parsing output: 122/ for test: gem_exec_schedule results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: gem_ctx_param results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: gem_partial_pwrite_pread results: parsing output: 127/ for test: core_setmaster results: parsing output: 128/ for test: syncobj_wait results: parsing output: 129/ for test: kms_chamelium_hpd results: parsing output: 130/ for test: kms_pipe_b_c_ivb Done.