[57.065162] Initializing watchdogs [57.065215] /dev/watchdog0 [57.080493] [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.085015] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.087699] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.091020] [001/156] (960s left) kms_pm_rpm (pm-caching) [58.688968] Starting subtest: pm-caching [58.694374] Subtest pm-caching: SKIP (0.000s) [59.416587] [002/156] (958s left) perf (gen12-group-exclusive-stream-ctx-handle) [59.555745] Starting subtest: gen12-group-exclusive-stream-ctx-handle [59.580282] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.024s) [59.624714] [003/156] (958s left) gem_eio (wait-wedge-10ms) [61.380076] Starting subtest: wait-wedge-10ms [63.355989] Subtest wait-wedge-10ms: SUCCESS (1.965s) [63.487822] [004/156] (954s left) kms_chamelium_frames (hdmi-crc-fast) [63.886687] Subtest hdmi-crc-fast: SKIP (0.000s) [64.722496] [005/156] (953s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-pwrite) [64.831167] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-pwrite [64.835707] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [64.956106] [006/156] (952s left) i915_hangman (engine-engine-hang) [65.032440] Starting subtest: engine-engine-hang [65.034683] Starting dynamic subtest: rcs0 [66.278110] Dynamic subtest rcs0: SUCCESS (1.241s) [66.298529] Starting dynamic subtest: bcs0 [68.262122] Dynamic subtest bcs0: SUCCESS (1.976s) [68.271718] Starting dynamic subtest: vcs0 [70.246254] Dynamic subtest vcs0: SUCCESS (1.980s) [70.255973] Starting dynamic subtest: vcs1 [72.227378] Dynamic subtest vcs1: SUCCESS (1.977s) [72.240201] Starting dynamic subtest: vecs0 [74.275230] Dynamic subtest vecs0: SUCCESS (2.045s) [74.287150] Starting dynamic subtest: ccs0 [76.260844] Dynamic subtest ccs0: SUCCESS (1.982s) [76.264449] Subtest engine-engine-hang: SUCCESS (11.209s) [76.342151] [007/156] (941s left) gem_exec_whisper (basic-queues-priority-all) [76.408626] Starting subtest: basic-queues-priority-all [98.711042] Subtest basic-queues-priority-all: SUCCESS (22.297s) [98.905469] [008/156] (918s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [98.973119] Starting subtest: invalid-multi-wait-all-unsubmitted [98.975550] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [99.061780] [009/156] (918s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt) [99.174086] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt [99.178335] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [99.273805] [010/156] (918s left) gem_exec_fence (syncobj-timeline-invalid-wait) [99.841551] Starting subtest: syncobj-timeline-invalid-wait [99.843934] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [101.391807] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true [101.395183] [011/156] (916s left) gem_exec_whisper (basic-contexts-forked) [101.447886] Starting subtest: basic-contexts-forked [124.683757] Subtest basic-contexts-forked: SUCCESS (23.235s) [124.866610] [012/156] (893s left) syncobj_wait (multi-wait-all-submitted) [124.928488] Starting subtest: multi-wait-all-submitted [125.033862] Subtest multi-wait-all-submitted: SUCCESS (0.106s) [125.137931] [013/156] (892s left) api_intel_bb (blit-noreloc-purge-cache) [125.186840] Starting subtest: blit-noreloc-purge-cache [125.202832] Subtest blit-noreloc-purge-cache: SUCCESS (0.017s) [125.353020] [014/156] (892s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [125.454953] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [125.457367] Starting dynamic subtest: pipe-A-eDP-1 [141.484143] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.574s) [141.496371] Starting dynamic subtest: pipe-B-eDP-1 [158.466468] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.446s) [158.478279] Starting dynamic subtest: pipe-C-eDP-1 [175.428944] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.414s) [175.438919] Starting dynamic subtest: pipe-D-eDP-1 [192.410378] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.320s) [192.412709] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.756s) [193.597394] [015/156] (824s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-cpu) [193.715068] Starting subtest: psrhdr-rgb101010-draw-mmap-cpu [193.719521] Subtest psrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [193.844606] [016/156] (824s left) gem_exec_parallel (engines) [193.922744] Starting subtest: engines [193.925043] Starting dynamic subtest: basic [197.354545] Dynamic subtest basic: SUCCESS (3.387s) [197.368105] Starting dynamic subtest: contexts [201.758764] Dynamic subtest contexts: SUCCESS (4.368s) [201.771836] Starting dynamic subtest: fds [205.660965] Dynamic subtest fds: SUCCESS (3.883s) [205.674345] Starting dynamic subtest: userptr [207.403268] Dynamic subtest userptr: SUCCESS (1.735s) [207.405900] Subtest engines: SUCCESS (13.377s) [207.596646] [017/156] (810s left) kms_async_flips (basic-modeset-with-all-modifiers-formats) [207.689612] Starting subtest: basic-modeset-with-all-modifiers-formats [208.078578] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888 [208.894789] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.814s) [208.907750] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010 [208.916012] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s) [208.926907] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F [208.937899] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s) [208.953220] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565 [209.093516] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s) [209.104066] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888 [209.116470] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s) [209.127366] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010 [209.138329] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s) [209.148791] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F [209.160528] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s) [209.171103] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV [209.182754] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s) [209.193594] Starting dynamic subtest: pipe-A-eDP-1-4-Y210 [209.205371] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s) [209.219999] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888 [209.227346] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s) [209.237991] Starting dynamic subtest: pipe-A-eDP-1-4-XV30 [209.249614] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s) [209.259718] Starting dynamic subtest: pipe-A-eDP-1-4-XV36 [209.273107] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.023s) [209.289587] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565 [209.427862] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.154s) [209.441784] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888 [209.450103] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s) [209.460931] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010 [209.472468] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s) [209.482531] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F [209.494664] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s) [209.506537] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV [209.517147] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s) [209.527769] Starting dynamic subtest: pipe-A-eDP-1-x-Y210 [209.539514] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s) [209.551118] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888 [209.561542] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s) [209.573040] Starting dynamic subtest: pipe-A-eDP-1-x-XV30 [209.583703] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s) [209.593547] Starting dynamic subtest: pipe-A-eDP-1-x-XV36 [209.606327] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s) [209.622588] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565 [209.773566] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.167s) [209.785050] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888 [209.795744] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s) [209.805907] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010 [209.818094] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s) [209.828148] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F [209.840379] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s) [209.850489] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV [209.862207] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s) [209.871960] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210 [209.884522] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s) [209.894194] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888 [209.906798] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s) [209.916395] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30 [209.928871] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s) [209.938399] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36 [209.951264] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s) [210.344765] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.649s) [211.178817] [018/156] (807s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [211.278747] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [211.283034] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [211.346884] [019/156] (807s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [211.454635] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [211.458847] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [211.543929] [020/156] (806s left) gem_ctx_param (vm) [211.593931] Starting subtest: vm [211.646228] Subtest vm: SUCCESS (0.051s) [211.798925] [021/156] (806s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [211.924157] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [211.928529] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [212.072879] [022/156] (806s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [212.204235] Starting subtest: 2x-long-cursor-vs-flip-atomic [212.207902] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s) [212.351577] [023/156] (806s left) gem_exec_reloc (basic-cpu-gtt-active) [212.403898] Subtest basic-cpu-gtt-active: SKIP (0.000s) [212.466184] [024/156] (806s left) prime_self_import (basic-llseek-size) [212.498741] Starting subtest: basic-llseek-size [212.513340] Subtest basic-llseek-size: SUCCESS (0.015s) [212.610136] [025/156] (806s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [212.723193] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [212.726628] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [212.830456] [026/156] (805s left) kms_joiner (basic-force-ultra-joiner) [212.928724] Starting subtest: basic-force-ultra-joiner [212.932491] Subtest basic-force-ultra-joiner: SKIP (0.000s) [212.996577] [027/156] (805s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt) [213.087750] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt [213.091215] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [213.193003] [028/156] (805s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [213.283960] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [213.287485] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [213.400732] [029/156] (805s left) kms_psr (fbc-pr-cursor-mmap-cpu) [213.494325] Starting subtest: fbc-pr-cursor-mmap-cpu [213.498080] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s) [213.567907] [030/156] (805s left) kms_vblank (query-busy) [213.670009] Starting subtest: query-busy [213.671869] Starting dynamic subtest: pipe-A-eDP-1 [215.565953] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.892s) [215.582782] Starting dynamic subtest: pipe-D-eDP-1 [218.152262] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.581s) [218.154691] Subtest query-busy: SUCCESS (4.477s) [218.960384] [031/156] (799s left) kms_flip (basic-flip-vs-wf_vblank) [219.062501] Starting subtest: basic-flip-vs-wf_vblank [219.064375] Starting dynamic subtest: A-eDP1 [221.007322] Dynamic subtest A-eDP1: SUCCESS (1.944s) [221.018039] Starting dynamic subtest: B-eDP1 [222.943419] Dynamic subtest B-eDP1: SUCCESS (1.933s) [222.954116] Starting dynamic subtest: C-eDP1 [224.866795] Dynamic subtest C-eDP1: SUCCESS (1.924s) [224.877470] Starting dynamic subtest: D-eDP1 [226.795709] Dynamic subtest D-eDP1: SUCCESS (1.929s) [226.799978] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.740s) [228.022003] [032/156] (790s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [228.123682] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [228.758698] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s) [228.911671] [033/156] (790s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [229.003120] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [229.007358] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [229.106427] [034/156] (789s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [229.208568] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt [229.212455] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [229.315133] [035/156] (789s left) syncobj_wait (signal) [229.362352] Starting subtest: signal [229.364561] Subtest signal: SUCCESS (0.000s) [229.454447] [036/156] (789s left) kms_cursor_edge_walk (128x128-left-edge) [229.543353] Starting subtest: 128x128-left-edge [229.545728] Starting dynamic subtest: pipe-A-eDP-1 [232.988405] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.445s) [233.000604] Starting dynamic subtest: pipe-D-eDP-1 [236.123520] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s) [236.125407] Subtest 128x128-left-edge: SUCCESS (6.581s) [236.939122] [037/156] (782s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [237.045635] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [244.039973] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.001s) [244.156625] [038/156] (775s left) perf (non-system-wide-paranoid) [244.244269] Starting subtest: non-system-wide-paranoid [244.268284] Subtest non-system-wide-paranoid: SUCCESS (0.024s) [244.321258] [039/156] (774s left) kms_hdmi_inject (inject-4k) [244.684347] Starting subtest: inject-4k [245.035744] Subtest inject-4k: SUCCESS (0.352s) [245.524793] [040/156] (773s left) perf_pmu (render-node-busy) [245.583812] Starting subtest: render-node-busy [245.586128] Starting dynamic subtest: rcs0 [246.169968] Dynamic subtest rcs0: SUCCESS (0.585s) [246.183323] Starting dynamic subtest: bcs0 [246.735546] Dynamic subtest bcs0: SUCCESS (0.564s) [246.748080] Starting dynamic subtest: vcs0 [248.362660] Dynamic subtest vcs0: SUCCESS (1.623s) [248.376108] Starting dynamic subtest: vcs1 [250.410143] Dynamic subtest vcs1: SUCCESS (2.045s) [250.423988] Starting dynamic subtest: vecs0 [252.394087] Dynamic subtest vecs0: SUCCESS (1.981s) [252.407316] Starting dynamic subtest: ccs0 [252.962245] Dynamic subtest ccs0: SUCCESS (0.567s) [252.964916] Subtest render-node-busy: SUCCESS (7.377s) [253.040729] [041/156] (766s left) gem_mmap_gtt (cpuset-medium-copy) [253.096374] Subtest cpuset-medium-copy: SKIP (0.000s) [253.166593] [042/156] (766s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [253.264463] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [253.268534] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [253.372637] [043/156] (766s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [253.492618] Starting subtest: verify-pxp-execution-after-suspend-resume [260.501305] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.007s) [260.652044] [044/156] (758s left) gem_create (create-ext-placement-all) [260.828121] Starting subtest: create-ext-placement-all [260.830673] Subtest create-ext-placement-all: SUCCESS (0.000s) [260.943622] [045/156] (758s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [261.330110] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [262.164965] [046/156] (757s left) gem_userptr_blits (process-exit-busy) [262.233578] Starting subtest: process-exit-busy [262.242547] Subtest process-exit-busy: SUCCESS (0.012s) [262.394660] [047/156] (757s left) gem_busy (extended) [262.581851] Starting subtest: extended [262.584374] Starting dynamic subtest: rcs0 [262.678596] Dynamic subtest rcs0: SUCCESS (0.097s) [262.692571] Starting dynamic subtest: bcs0 [262.719770] Dynamic subtest bcs0: SUCCESS (0.040s) [262.731035] Starting dynamic subtest: vcs0 [264.362133] Dynamic subtest vcs0: SUCCESS (1.639s) [264.375972] Starting dynamic subtest: vcs1 [266.410335] Dynamic subtest vcs1: SUCCESS (2.046s) [266.424083] Starting dynamic subtest: vecs0 [268.394895] Dynamic subtest vecs0: SUCCESS (1.982s) [268.408496] Starting dynamic subtest: ccs0 [268.439274] Dynamic subtest ccs0: SUCCESS (0.044s) [268.441602] Subtest extended: SUCCESS (5.858s) [268.652798] [048/156] (750s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [268.745125] Starting subtest: plane-upscale-20x20-with-pixel-format [268.747338] Starting dynamic subtest: pipe-A [269.795580] Dynamic subtest pipe-A: SUCCESS (1.052s) [269.805726] Starting dynamic subtest: pipe-B [271.970729] Dynamic subtest pipe-B: SUCCESS (2.174s) [271.981413] Starting dynamic subtest: pipe-C [273.126530] Dynamic subtest pipe-C: SUCCESS (1.155s) [273.137558] Starting dynamic subtest: pipe-D [274.338570] Dynamic subtest pipe-D: SUCCESS (1.211s) [274.340960] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.594s) [275.490512] [049/156] (744s left) i915_selftest (mock) [280.177267] Starting subtest: mock [280.179608] Starting dynamic subtest: sanitycheck [280.866171] Dynamic subtest sanitycheck: SUCCESS (0.693s) [280.876524] Starting dynamic subtest: shmem [281.566533] Dynamic subtest shmem: SUCCESS (0.698s) [281.577060] Starting dynamic subtest: fence [289.506212] Dynamic subtest fence: SUCCESS (7.935s) [289.522085] Starting dynamic subtest: scatterlist [291.198352] Dynamic subtest scatterlist: SUCCESS (1.690s) [291.209202] Starting dynamic subtest: syncmap [294.448385] Dynamic subtest syncmap: SUCCESS (3.247s) [294.460321] Starting dynamic subtest: uncore [295.150525] Dynamic subtest uncore: SUCCESS (0.700s) [295.161058] Starting dynamic subtest: ring [295.839775] Dynamic subtest ring: SUCCESS (0.687s) [295.850331] Starting dynamic subtest: engine [296.521472] Dynamic subtest engine: SUCCESS (0.680s) [296.531815] Starting dynamic subtest: timelines [300.445947] Dynamic subtest timelines: SUCCESS (3.921s) [300.455926] Starting dynamic subtest: requests [304.039307] Dynamic subtest requests: SUCCESS (3.591s) [304.050500] Starting dynamic subtest: objects [304.870877] Dynamic subtest objects: SUCCESS (0.830s) [304.881109] Starting dynamic subtest: phys [305.673917] Dynamic subtest phys: SUCCESS (0.802s) [305.683218] Starting dynamic subtest: dmabuf [306.465234] Dynamic subtest dmabuf: SUCCESS (0.791s) [306.475179] Starting dynamic subtest: vma [312.289735] Dynamic subtest vma: SUCCESS (5.820s) [312.300273] Starting dynamic subtest: evict [313.738273] Dynamic subtest evict: SUCCESS (1.447s) [313.748250] Starting dynamic subtest: gtt [317.073906] Dynamic subtest gtt: SUCCESS (3.333s) [317.084419] Starting dynamic subtest: hugepages [318.000558] Dynamic subtest hugepages: SUCCESS (0.925s) [318.011145] Starting dynamic subtest: memory_region [320.575348] Dynamic subtest memory_region: SUCCESS (2.573s) [320.578073] Subtest mock: SUCCESS (40.393s) [320.607549] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [320.608259] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [320.611839] [050/156] (699s left) prime_vgem (sync) [322.177206] Starting subtest: sync [322.180895] Starting dynamic subtest: rcs0 [322.226216] Dynamic subtest rcs0: SUCCESS (0.051s) [322.238776] Starting dynamic subtest: bcs0 [322.293535] Dynamic subtest bcs0: SUCCESS (0.066s) [322.302945] Starting dynamic subtest: vcs0 [322.338913] Dynamic subtest vcs0: SUCCESS (0.045s) [322.348381] Starting dynamic subtest: vcs1 [322.388006] Dynamic subtest vcs1: SUCCESS (0.048s) [322.397062] Starting dynamic subtest: vecs0 [322.435531] Dynamic subtest vecs0: SUCCESS (0.047s) [322.444531] Starting dynamic subtest: ccs0 [322.481513] Dynamic subtest ccs0: SUCCESS (0.045s) [322.483745] Subtest sync: SUCCESS (0.307s) [322.560523] [FACT prime_vgem (sync)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [322.561772] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.i915: true [322.565585] [051/156] (697s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [322.687965] Starting subtest: short-flip-after-cursor-atomic-transitions [323.667279] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.976s) [324.560999] [052/156] (695s left) kms_frontbuffer_tracking (fbc-2p-rte) [324.671090] Starting subtest: fbc-2p-rte [324.675348] Subtest fbc-2p-rte: SKIP (0.000s) [324.777794] [053/156] (695s left) kms_vrr (flip-basic-fastset) [324.869226] Starting subtest: flip-basic-fastset [324.875873] Subtest flip-basic-fastset: SKIP (0.000s) [324.942790] [054/156] (694s left) gem_ctx_param (basic) [324.992192] Starting subtest: basic [324.994558] Subtest basic: SUCCESS (0.001s) [325.128951] [055/156] (694s left) sw_sync (sync_multi_consumer_producer) [325.161413] Starting subtest: sync_multi_consumer_producer [325.458025] Subtest sync_multi_consumer_producer: SUCCESS (0.297s) [325.532400] [056/156] (694s left) vgem_basic (debugfs) [325.573458] Starting subtest: debugfs [325.575660] Subtest debugfs: SUCCESS (0.000s) [325.639324] [057/156] (694s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [325.784904] Starting subtest: dp-mst-lic-type-0-hdcp14 [325.789670] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [325.901088] [058/156] (694s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [326.010445] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [326.014816] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [326.106631] [059/156] (693s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc) [326.197353] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc [326.201693] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [326.301352] [060/156] (693s left) kms_properties (colorop-properties-atomic) [326.393626] Starting subtest: colorop-properties-atomic [326.396005] Starting dynamic subtest: pipe-A-eDP-1 [326.769356] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.376s) [326.779649] Starting dynamic subtest: pipe-B-eDP-1 [327.827599] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.057s) [327.837939] Starting dynamic subtest: pipe-C-eDP-1 [328.875821] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.044s) [328.886032] Starting dynamic subtest: pipe-D-eDP-1 [330.008525] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s) [330.010712] Subtest colorop-properties-atomic: SUCCESS (3.614s) [330.813448] [061/156] (689s left) kms_pm_rpm (dpms-non-lpsp) [332.551492] Starting subtest: dpms-non-lpsp [332.556182] Subtest dpms-non-lpsp: SKIP (0.001s) [333.081613] [062/156] (687s left) kms_cdclk (mode-transition-all-outputs) [333.175178] Starting subtest: mode-transition-all-outputs [333.469865] Subtest mode-transition-all-outputs: SKIP (0.291s) [334.297967] [063/156] (685s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [334.386573] Starting subtest: crc-primary-basic-y-tiled-ccs [334.388812] Starting dynamic subtest: pipe-A-eDP-1 [334.411367] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [334.424482] Starting dynamic subtest: pipe-B-eDP-1 [334.445925] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [334.455417] Starting dynamic subtest: pipe-C-eDP-1 [334.477013] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [334.485886] Starting dynamic subtest: pipe-D-eDP-1 [334.508138] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [334.512518] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [336.656714] [064/156] (683s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render) [336.755557] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render [336.759576] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [336.847688] [065/156] (683s left) gem_caching (reads) [336.901971] Subtest reads: SKIP (0.000s) [336.973987] [066/156] (683s left) sysfs_preempt_timeout (timeout) [337.030997] Starting subtest: timeout [337.033541] Starting dynamic subtest: vecs0 [346.412006] Dynamic subtest vecs0: SUCCESS (9.375s) [346.424901] Starting dynamic subtest: ccs0 [347.601699] Dynamic subtest ccs0: SUCCESS (1.190s) [347.614327] Starting dynamic subtest: vcs0 [357.415539] Dynamic subtest vcs0: SUCCESS (9.807s) [357.430976] Starting dynamic subtest: bcs0 [358.588650] Dynamic subtest bcs0: SUCCESS (1.172s) [358.601840] Starting dynamic subtest: rcs0 [359.855546] Dynamic subtest rcs0: SUCCESS (1.265s) [359.866507] Starting dynamic subtest: vcs1 [369.382527] Dynamic subtest vcs1: SUCCESS (9.522s) [369.385119] Subtest timeout: SUCCESS (32.343s) [369.472241] [067/156] (650s left) kms_cursor_legacy (cursor-vs-flip-legacy) [369.618225] Starting subtest: cursor-vs-flip-legacy [399.452764] Subtest cursor-vs-flip-legacy: SUCCESS (29.827s) [400.295557] [068/156] (620s left) kms_rotation_crc (primary-rotation-90) [400.387327] Starting subtest: primary-rotation-90 [400.391777] Subtest primary-rotation-90: SKIP (0.001s) [400.461156] [069/156] (620s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [400.578909] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [432.649040] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (32.060s) [433.539613] [070/156] (586s left) kms_atomic (plane-invalid-params-fence) [433.653492] Starting subtest: plane-invalid-params-fence [433.655747] Starting dynamic subtest: pipe-A-eDP-1 [434.011064] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s) [434.013425] Subtest plane-invalid-params-fence: SUCCESS (0.360s) [434.866901] [071/156] (585s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [434.960348] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [439.711194] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.755s) [439.826841] [072/156] (580s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [439.924352] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [439.926654] Starting dynamic subtest: pipe-A-eDP-1 [439.949866] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [439.960810] Starting dynamic subtest: pipe-B-eDP-1 [439.982360] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [439.992340] Starting dynamic subtest: pipe-C-eDP-1 [440.013870] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [440.023408] Starting dynamic subtest: pipe-D-eDP-1 [440.045960] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [440.050885] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [442.178134] [073/156] (578s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-pwrite) [442.270961] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-pwrite [442.275063] Subtest hdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [442.370549] [074/156] (578s left) kms_frontbuffer_tracking (hdr-1p-rte) [442.462144] Starting subtest: hdr-1p-rte [442.466281] Subtest hdr-1p-rte: SKIP (0.000s) [442.567914] [075/156] (578s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-pgflip-blt) [442.661864] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-pgflip-blt [442.665891] Subtest fbcpsrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [442.764586] [076/156] (578s left) kms_cursor_crc (cursor-random-32x10) [442.933472] Starting subtest: cursor-random-32x10 [442.982239] Subtest cursor-random-32x10: SKIP (0.042s) [443.260715] [077/156] (577s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [443.350158] Starting subtest: psr-rgb565-draw-render [450.538905] Subtest psr-rgb565-draw-render: SUCCESS (7.186s) [450.639696] [078/156] (570s left) gem_exec_schedule (noreorder-priority) [450.827370] Starting subtest: noreorder-priority [450.829308] Starting dynamic subtest: rcs0 [451.957901] Dynamic subtest rcs0: SUCCESS (1.133s) [451.971102] Starting dynamic subtest: vcs0 [453.355111] Dynamic subtest vcs0: SUCCESS (1.394s) [453.367129] Starting dynamic subtest: vcs1 [455.403825] Dynamic subtest vcs1: SUCCESS (2.044s) [455.416369] Starting dynamic subtest: vecs0 [457.383259] Dynamic subtest vecs0: SUCCESS (1.977s) [457.397350] Starting dynamic subtest: ccs0 [458.534946] Dynamic subtest ccs0: SUCCESS (1.150s) [458.537407] Subtest noreorder-priority: SUCCESS (7.710s) [458.730211] [079/156] (562s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [458.837437] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [465.613598] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.781s) [465.763999] [080/156] (555s left) kms_psr (fbc-psr2-primary-render) [465.864413] Starting subtest: fbc-psr2-primary-render [465.866713] Starting dynamic subtest: eDP-1 [465.871327] Dynamic subtest eDP-1: SKIP (0.000s) [465.875493] Subtest fbc-psr2-primary-render: SKIP (0.002s) [465.957008] [081/156] (555s left) gem_ctx_shared (single-timeline) [466.031351] Starting subtest: single-timeline [466.049816] Subtest single-timeline: SUCCESS (0.011s) [466.281512] [082/156] (554s left) gem_spin_batch (spin-all) [466.332958] Starting subtest: spin-all [466.345962] Subtest spin-all: SUCCESS (0.013s) [468.453318] [083/156] (552s left) prime_mmap (test_reprime) [468.511867] Starting subtest: test_reprime [468.514058] Starting dynamic subtest: test_reprime-smem [468.547475] Dynamic subtest test_reprime-smem: SUCCESS (0.035s) [468.550005] Subtest test_reprime: SUCCESS (0.037s) [468.673536] [084/156] (552s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt) [468.781018] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt [468.785118] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [468.879823] [085/156] (552s left) i915_pm_rc6_residency (rc6-fence) [468.935566] Starting subtest: rc6-fence [468.963171] Starting dynamic subtest: gt0 [481.286153] Dynamic subtest gt0: SUCCESS (12.319s) [481.299364] Starting dynamic subtest: gt1 [496.362662] Dynamic subtest gt1: SUCCESS (15.068s) [496.365335] Subtest rc6-fence: SUCCESS (27.422s) [496.476987] [086/156] (524s left) gem_pxp (create-regular-context-2) [496.592110] Starting subtest: create-regular-context-2 [496.595182] Subtest create-regular-context-2: SUCCESS (0.003s) [496.711202] [087/156] (524s left) gem_eio (wait-1us) [496.916573] Starting subtest: wait-1us [497.247554] Subtest wait-1us: SUCCESS (0.331s) [497.388365] [088/156] (523s left) gen9_exec_parse (bb-oversize) [497.448506] Subtest bb-oversize: SKIP (0.000s) [497.515367] [089/156] (523s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy) [497.605417] Starting subtest: fbchdr-modesetfrombusy [497.608826] Subtest fbchdr-modesetfrombusy: SKIP (0.000s) [497.737106] [090/156] (523s left) kms_cursor_crc (cursor-onscreen-256x256) [497.980900] Starting subtest: cursor-onscreen-256x256 [497.987472] Starting dynamic subtest: pipe-A-eDP-1 [500.106837] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.118s) [500.138038] Starting dynamic subtest: pipe-D-eDP-1 [502.926403] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.796s) [502.928874] Subtest cursor-onscreen-256x256: SUCCESS (4.945s) [503.819529] [091/156] (517s left) gem_exec_params (cliprects_ptr-dirt) [503.882886] Starting subtest: cliprects_ptr-dirt [503.885087] Subtest cliprects_ptr-dirt: SUCCESS (0.000s) [503.988361] [092/156] (517s left) gem_exec_suspend (basic) [504.045041] Starting subtest: basic [504.047245] Starting dynamic subtest: smem [505.387199] Dynamic subtest smem: SUCCESS (1.339s) [505.390048] Subtest basic: SUCCESS (1.341s) [505.572829] [093/156] (515s left) syncobj_timeline (wait-all-snapshot) [505.629575] Starting subtest: wait-all-snapshot [505.712671] Subtest wait-all-snapshot: SUCCESS (0.083s) [505.790701] [094/156] (515s left) kms_psr (fbc-psr-cursor-plane-move) [505.888616] Starting subtest: fbc-psr-cursor-plane-move [505.890909] Starting dynamic subtest: eDP-1 [505.894989] Dynamic subtest eDP-1: SKIP (0.000s) [505.898961] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [505.994804] [095/156] (515s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [506.061135] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [506.065552] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s) [506.264395] [096/156] (515s left) gem_exec_balancer (bonded-sync) [506.322882] Starting subtest: bonded-sync [506.327430] Subtest bonded-sync: SKIP (0.000s) [506.621163] [097/156] (515s left) gen3_render_mixed_blits [506.731872] [098/156] (515s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [506.784804] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [506.885654] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s) [506.968580] [099/156] (514s left) vgem_basic (dmabuf-export) [507.017704] Starting subtest: dmabuf-export [507.042159] Subtest dmabuf-export: SUCCESS (0.029s) [507.146676] [100/156] (514s left) kms_dsc (dsc-basic) [507.245134] Starting subtest: dsc-basic [507.257904] Subtest dsc-basic: SKIP (0.000s) [507.317741] [101/156] (514s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [507.412845] Starting subtest: y-tiled-addfb-size-offset-overflow [507.416859] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [507.511350] [102/156] (514s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite) [507.604835] Starting subtest: psr-rgb101010-draw-pwrite [515.480464] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.877s) [515.594258] [103/156] (506s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt) [515.693158] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt [515.697511] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [515.808170] [104/156] (506s left) kms_big_fb (4-tiled-addfb) [515.914458] Starting subtest: 4-tiled-addfb [515.916679] Subtest 4-tiled-addfb: SUCCESS (0.000s) [515.999248] [105/156] (506s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite) [516.100905] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite [516.105473] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [516.219770] [106/156] (505s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [516.314161] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [516.319070] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [516.417863] [107/156] (505s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [516.508082] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu [523.125972] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.619s) [523.254694] [108/156] (498s left) gem_userptr_blits (huge-split) [523.323919] Starting subtest: huge-split [523.329996] Subtest huge-split: SUCCESS (0.006s) [523.448180] [109/156] (498s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-render) [523.545152] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-render [523.549508] Subtest psrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [523.644706] [110/156] (498s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [523.734323] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [530.350709] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.620s) [530.479240] [111/156] (491s left) gem_tiled_pread_pwrite [530.623352] [112/156] (491s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [530.725041] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [530.729024] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [530.829455] [113/156] (491s left) gem_userptr_blits (usage-restrictions) [530.895817] Starting subtest: usage-restrictions [530.897642] Subtest usage-restrictions: SUCCESS (0.000s) [531.034945] [114/156] (491s left) gem_eio (in-flight-contexts-10ms) [531.273963] Starting subtest: in-flight-contexts-10ms [544.384069] Subtest in-flight-contexts-10ms: SUCCESS (13.106s) [544.572281] [115/156] (477s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [544.683615] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc [544.688174] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [544.801166] [116/156] (477s left) gem_render_copy_redux (normal) [544.860516] Starting subtest: normal [545.233005] Subtest normal: SUCCESS (0.371s) [545.359197] [117/156] (477s left) kms_psr (psr2-sprite-mmap-cpu) [545.452746] Starting subtest: psr2-sprite-mmap-cpu [545.454672] Starting dynamic subtest: eDP-1 [547.232418] Dynamic subtest eDP-1: SUCCESS (1.778s) [547.234730] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.779s) [548.109605] [118/156] (474s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite) [548.209723] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite [548.213721] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [548.301737] [119/156] (474s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier) [548.391603] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier [548.395875] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s) [548.467131] [120/156] (474s left) kms_psr (psr-suspend) [548.566610] Starting subtest: psr-suspend [548.568930] Starting dynamic subtest: eDP-1 [566.700736] Dynamic subtest eDP-1: SUCCESS (2.960s) [566.703335] Subtest psr-suspend: SUCCESS (2.961s) [567.596459] [121/156] (455s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [567.705513] Starting subtest: fbcpsr-2p-rte [567.710122] Subtest fbcpsr-2p-rte: SKIP (0.000s) [567.796309] [122/156] (455s left) kms_dp_link_training (uhbr-sst) [567.884115] Starting subtest: uhbr-sst [567.894932] Subtest uhbr-sst: SKIP (0.000s) [567.958083] [123/156] (454s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [568.043923] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [568.048904] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s) [568.118433] [124/156] (454s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [568.223762] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [568.228867] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [568.318770] [125/156] (454s left) syncobj_timeline (signal-array) [568.370141] Starting subtest: signal-array [568.372690] Subtest signal-array: SUCCESS (0.000s) [568.486537] [126/156] (454s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render) [568.578989] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render [575.494387] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.848s) [575.649058] [127/156] (447s left) gem_exec_reloc (basic-cpu-read) [575.704746] Subtest basic-cpu-read: SKIP (0.000s) [575.772495] [128/156] (447s left) gem_exec_fence (concurrent) [575.952161] Starting subtest: concurrent [575.957892] Subtest concurrent: SKIP (0.000s) [577.601197] [129/156] (445s left) kms_properties (get_properties-sanity-atomic) [577.697869] Starting subtest: get_properties-sanity-atomic [577.700473] Subtest get_properties-sanity-atomic: SUCCESS (0.003s) [577.775853] [130/156] (445s left) kms_big_fb (linear-8bpp-rotate-180) [577.880914] Starting subtest: linear-8bpp-rotate-180 [579.201606] Subtest linear-8bpp-rotate-180: SUCCESS (1.317s) [579.325109] [131/156] (443s left) kms_lease (setcrtc-implicit-plane) [579.422954] Starting subtest: setcrtc-implicit-plane [579.425373] Starting dynamic subtest: pipe-A-eDP-1 [579.897823] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.472s) [579.909856] Starting dynamic subtest: pipe-B-eDP-1 [581.087675] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.185s) [581.099684] Starting dynamic subtest: pipe-C-eDP-1 [582.201824] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s) [582.213651] Starting dynamic subtest: pipe-D-eDP-1 [583.329114] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s) [583.331719] Subtest setcrtc-implicit-plane: SUCCESS (3.895s) [584.185409] [132/156] (439s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [584.275926] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [584.278544] Starting dynamic subtest: pipe-A-default-mode [587.053012] Dynamic subtest pipe-A-default-mode: SUCCESS (2.771s) [587.055853] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.773s) [587.897175] [133/156] (435s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [587.998081] Starting subtest: plane-scaler-unity-scaling-with-rotation [588.000705] Starting dynamic subtest: pipe-A [588.235572] Dynamic subtest pipe-A: SUCCESS (0.240s) [588.249010] Starting dynamic subtest: pipe-B [589.588047] Dynamic subtest pipe-B: SUCCESS (1.349s) [589.599629] Starting dynamic subtest: pipe-C [590.917820] Dynamic subtest pipe-C: SUCCESS (1.327s) [590.929370] Starting dynamic subtest: pipe-D [592.261657] Dynamic subtest pipe-D: SUCCESS (1.341s) [592.264300] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.261s) [593.418498] [134/156] (429s left) gem_exec_schedule (submit-late-slice) [593.491554] Starting subtest: submit-late-slice [593.494115] Starting dynamic subtest: rcs0 [593.520028] Dynamic subtest rcs0: SUCCESS (0.037s) [593.535912] Starting dynamic subtest: bcs0 [593.553394] Dynamic subtest bcs0: SUCCESS (0.031s) [593.564353] Starting dynamic subtest: vcs0 [593.587740] Dynamic subtest vcs0: SUCCESS (0.034s) [593.598883] Starting dynamic subtest: vcs1 [593.619165] Dynamic subtest vcs1: SUCCESS (0.031s) [593.630853] Starting dynamic subtest: vecs0 [593.656586] Dynamic subtest vecs0: SUCCESS (0.036s) [593.668661] Starting dynamic subtest: ccs0 [593.691715] Dynamic subtest ccs0: SUCCESS (0.034s) [593.694811] Subtest submit-late-slice: SUCCESS (0.210s) [595.661833] [135/156] (427s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [595.766789] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [595.771838] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [595.869912] [136/156] (427s left) kms_color (ctm-green-to-red) [595.956134] Starting subtest: ctm-green-to-red [595.958965] Starting dynamic subtest: pipe-A-eDP-1 [596.629867] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.674s) [596.641107] Starting dynamic subtest: pipe-B-eDP-1 [598.031718] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s) [598.044178] Starting dynamic subtest: pipe-C-eDP-1 [599.363832] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.333s) [599.375708] Starting dynamic subtest: pipe-D-eDP-1 [600.696417] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s) [600.698901] Subtest ctm-green-to-red: SUCCESS (4.741s) [601.542300] [137/156] (421s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [601.645951] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt [601.650982] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [601.744071] [138/156] (421s left) kms_hdr (static-toggle-suspend) [601.833975] Starting subtest: static-toggle-suspend [601.836831] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [601.841986] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [601.853630] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [601.858758] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [601.864032] Subtest static-toggle-suspend: SKIP (0.003s) [601.920608] [139/156] (421s left) kms_flip (2x-flip-vs-suspend-interruptible) [602.019264] Starting subtest: 2x-flip-vs-suspend-interruptible [602.023803] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s) [602.118090] [140/156] (421s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [602.202114] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [602.204825] Starting dynamic subtest: pipe-A-eDP-1 [602.278004] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [602.289764] Starting dynamic subtest: pipe-B-eDP-1 [602.359904] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [602.373120] Starting dynamic subtest: pipe-C-eDP-1 [602.440117] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [602.451086] Starting dynamic subtest: pipe-D-eDP-1 [602.504567] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [602.508951] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s) [604.500832] [141/156] (419s left) core_getstats (basic) [604.551026] Starting subtest: basic [604.553873] Subtest basic: SUCCESS (0.000s) [604.641321] [142/156] (419s left) gem_mmap_offset (oob-read) [604.693665] Starting subtest: oob-read [604.696137] Subtest oob-read: SUCCESS (0.001s) [604.791760] [143/156] (418s left) gem_ctx_persistence (heartbeat-stop) [604.849364] Starting subtest: heartbeat-stop [604.854981] Subtest heartbeat-stop: SKIP (0.000s) [604.950501] [144/156] (418s left) dumb_buffer (map-invalid-size) [605.005718] Starting subtest: map-invalid-size [605.007937] Subtest map-invalid-size: SUCCESS (0.000s) [605.088100] [145/156] (418s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [605.195584] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu [605.200745] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [605.286130] [146/156] (418s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [605.342021] Starting subtest: etime-multi-wait-all-for-submit-submitted [605.451960] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s) [605.531467] [147/156] (418s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [605.628826] Starting subtest: extended-pageflip-modeset-hang-oldfb [605.631538] Starting dynamic subtest: pipe-A [613.525658] Dynamic subtest pipe-A: SUCCESS (7.896s) [613.536933] Starting dynamic subtest: pipe-D [622.134989] Dynamic subtest pipe-D: SUCCESS (8.601s) [622.137875] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.502s) [622.977481] [148/156] (400s left) kms_plane_alpha_blend (alpha-7efc) [623.073112] Starting subtest: alpha-7efc [623.369122] Starting dynamic subtest: pipe-A-eDP-1 [624.008914] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.638s) [624.037857] Starting dynamic subtest: pipe-D-eDP-1 [625.299963] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.270s) [625.302712] Subtest alpha-7efc: SUCCESS (2.228s) [626.157448] [149/156] (397s left) gem_mmap_gtt (basic-small-copy-odd) [626.208136] Subtest basic-small-copy-odd: SKIP (0.000s) [626.270558] [150/156] (397s left) gem_workarounds (reset-fd) [626.338753] Starting subtest: reset-fd [626.508884] Subtest reset-fd: SUCCESS (0.170s) [626.644179] [151/156] (397s left) syncobj_timeline (invalid-query-zero-handles) [626.697399] Starting subtest: invalid-query-zero-handles [626.699937] Subtest invalid-query-zero-handles: SUCCESS (0.000s) [626.797532] [152/156] (397s left) kms_big_fb (x-tiled-8bpp-rotate-0) [626.894438] Starting subtest: x-tiled-8bpp-rotate-0 [628.164545] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.269s) [628.279970] [153/156] (395s left) i915_drm_fdinfo (busy) [628.318643] Starting subtest: busy [628.321125] Starting dynamic subtest: rcs0 [628.332251] Dynamic subtest rcs0: SKIP (0.013s) [628.344351] Starting dynamic subtest: bcs0 [628.348992] Dynamic subtest bcs0: SKIP (0.010s) [628.362745] Starting dynamic subtest: vcs0 [628.367376] Dynamic subtest vcs0: SKIP (0.000s) [628.378428] Starting dynamic subtest: vcs1 [628.382837] Dynamic subtest vcs1: SKIP (0.000s) [628.393219] Starting dynamic subtest: vecs0 [628.397844] Dynamic subtest vecs0: SKIP (0.000s) [628.408347] Starting dynamic subtest: ccs0 [628.413023] Dynamic subtest ccs0: SKIP (0.000s) [628.417789] Subtest busy: SKIP (0.028s) [628.457002] [154/156] (395s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [628.557551] Starting subtest: yf-tiled-64bpp-rotate-180 [628.561871] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [628.653065] [155/156] (395s left) gem_ctx_create (basic-files) [628.714591] Starting subtest: basic-files [630.730766] Subtest basic-files: SUCCESS (2.015s) [632.609347] [156/156] (391s left) kms_psr (psr2-cursor-plane-onoff) [632.700946] Starting subtest: psr2-cursor-plane-onoff [632.703278] Starting dynamic subtest: eDP-1 [634.441629] Dynamic subtest eDP-1: SUCCESS (1.737s) [634.444159] Subtest psr2-cursor-plane-onoff: SUCCESS (1.738s) [635.337320] Closing watchdogs results: parsing output: 0/ for test: kms_pm_rpm results: parsing output: 1/ for test: perf results: parsing output: 2/ for test: gem_eio results: parsing output: 3/ for test: kms_chamelium_frames results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: i915_hangman results: parsing output: 6/ for test: gem_exec_whisper results: parsing output: 7/ for test: syncobj_wait results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: gem_exec_fence results: parsing output: 10/ for test: gem_exec_whisper results: parsing output: 11/ for test: syncobj_wait results: parsing output: 12/ for test: api_intel_bb results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_exec_parallel results: parsing output: 16/ for test: kms_async_flips results: parsing output: 17/ for test: kms_psr2_sf results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_ctx_param results: parsing output: 20/ for test: kms_cursor_legacy results: parsing output: 21/ for test: kms_cursor_legacy results: parsing output: 22/ for test: gem_exec_reloc results: parsing output: 23/ for test: prime_self_import results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_joiner results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: kms_vblank results: parsing output: 30/ for test: kms_flip results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: syncobj_wait results: parsing output: 35/ for test: kms_cursor_edge_walk results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: perf results: parsing output: 38/ for test: kms_hdmi_inject results: parsing output: 39/ for test: perf_pmu results: parsing output: 40/ for test: gem_mmap_gtt results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_pxp results: parsing output: 43/ for test: gem_create results: parsing output: 44/ for test: kms_chamelium_hpd results: parsing output: 45/ for test: gem_userptr_blits results: parsing output: 46/ for test: gem_busy results: parsing output: 47/ for test: kms_plane_scaling results: parsing output: 48/ for test: i915_selftest results: parsing output: 49/ for test: prime_vgem results: parsing output: 50/ for test: kms_cursor_legacy results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_vrr results: parsing output: 53/ for test: gem_ctx_param results: parsing output: 54/ for test: sw_sync results: parsing output: 55/ for test: vgem_basic results: parsing output: 56/ for test: kms_content_protection results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_properties results: parsing output: 60/ for test: kms_pm_rpm results: parsing output: 61/ for test: kms_cdclk results: parsing output: 62/ for test: kms_ccs results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_caching results: parsing output: 65/ for test: sysfs_preempt_timeout results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: kms_rotation_crc results: parsing output: 68/ for test: kms_cursor_legacy results: parsing output: 69/ for test: kms_atomic results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_ccs results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_cursor_crc results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_exec_schedule results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_psr results: parsing output: 80/ for test: gem_ctx_shared results: parsing output: 81/ for test: gem_spin_batch results: parsing output: 82/ for test: prime_mmap results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: i915_pm_rc6_residency results: parsing output: 85/ for test: gem_pxp results: parsing output: 86/ for test: gem_eio results: parsing output: 87/ for test: gen9_exec_parse results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_cursor_crc results: parsing output: 90/ for test: gem_exec_params results: parsing output: 91/ for test: gem_exec_suspend results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: kms_psr results: parsing output: 94/ for test: gem_render_copy results: parsing output: 95/ for test: gem_exec_balancer results: parsing output: 96/ for test: gen3_render_mixed_blits results: parsing output: 97/ for test: syncobj_timeline results: parsing output: 98/ for test: vgem_basic results: parsing output: 99/ for test: kms_dsc results: parsing output: 100/ for test: kms_big_fb results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_userptr_blits results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: gem_tiled_pread_pwrite results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_userptr_blits results: parsing output: 113/ for test: gem_eio results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: gem_render_copy_redux results: parsing output: 116/ for test: kms_psr results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_plane results: parsing output: 119/ for test: kms_psr results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_dp_link_training results: parsing output: 122/ for test: kms_plane results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_exec_reloc results: parsing output: 127/ for test: gem_exec_fence results: parsing output: 128/ for test: kms_properties results: parsing output: 129/ for test: kms_big_fb results: parsing output: 130/ for test: kms_lease results: parsing output: 131/ for test: kms_flip_scaled_crc results: parsing output: 132/ for test: kms_plane_scaling results: parsing output: 133/ for test: gem_exec_schedule results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: kms_color results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_hdr results: parsing output: 138/ for test: kms_flip results: parsing output: 139/ for test: kms_ccs results: parsing output: 140/ for test: core_getstats results: parsing output: 141/ for test: gem_mmap_offset results: parsing output: 142/ for test: gem_ctx_persistence results: parsing output: 143/ for test: dumb_buffer results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: syncobj_timeline results: parsing output: 146/ for test: kms_busy results: parsing output: 147/ for test: kms_plane_alpha_blend results: parsing output: 148/ for test: gem_mmap_gtt results: parsing output: 149/ for test: gem_workarounds results: parsing output: 150/ for test: syncobj_timeline results: parsing output: 151/ for test: kms_big_fb results: parsing output: 152/ for test: i915_drm_fdinfo results: parsing output: 153/ for test: kms_big_fb results: parsing output: 154/ for test: gem_ctx_create results: parsing output: 155/ for test: kms_psr Done.