[58.933157] Initializing watchdogs [58.933202] /dev/watchdog0 [58.947256] [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] [58.951552] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.953795] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.957187] [001/133] (960s left) syncobj_basic (bad-create-flags) [59.037108] Starting subtest: bad-create-flags [59.039466] Subtest bad-create-flags: SUCCESS (0.000s) [59.184655] [002/133] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [64.239597] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [64.241699] Starting dynamic subtest: pipe-A-eDP-1 [71.000742] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.744s) [71.008074] Starting dynamic subtest: pipe-B-eDP-1 [77.858653] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.850s) [77.860974] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.598s) [78.746165] [003/133] (940s left) gem_ccs (block-copy-compressed) [78.817759] Starting subtest: block-copy-compressed [78.822291] Subtest block-copy-compressed: SKIP (0.000s) [78.937941] [004/133] (940s left) kms_sequence (get-forked-busy) [79.033643] Starting subtest: get-forked-busy [79.035854] Starting dynamic subtest: pipe-A-eDP-1 [80.969637] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s) [80.978941] Starting dynamic subtest: pipe-B-eDP-1 [83.548543] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.577s) [83.558423] Starting dynamic subtest: pipe-C-eDP-1 [86.159783] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.607s) [86.169312] Starting dynamic subtest: pipe-D-eDP-1 [88.797421] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.633s) [88.799462] Subtest get-forked-busy: SUCCESS (9.754s) [89.693046] [005/133] (929s left) sysfs_preempt_timeout (timeout) [89.769689] Starting subtest: timeout [89.772121] Starting dynamic subtest: vecs0 [98.912728] Dynamic subtest vecs0: SUCCESS (9.135s) [98.921675] Starting dynamic subtest: ccs0 [100.336428] Dynamic subtest ccs0: SUCCESS (1.424s) [100.346460] Starting dynamic subtest: vcs0 [109.933056] Dynamic subtest vcs0: SUCCESS (9.590s) [109.946148] Starting dynamic subtest: bcs0 [111.239389] Dynamic subtest bcs0: SUCCESS (1.305s) [111.249779] Starting dynamic subtest: rcs0 [112.553407] Dynamic subtest rcs0: SUCCESS (1.313s) [112.563214] Starting dynamic subtest: vcs1 [121.962667] Dynamic subtest vcs1: SUCCESS (9.404s) [121.973191] Subtest timeout: SUCCESS (32.179s) [122.052382] [006/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [122.153041] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [122.157257] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [122.284389] [007/133] (897s left) gem_ctx_persistence (legacy-engines-queued) [122.343267] Starting subtest: legacy-engines-queued [122.345603] Starting dynamic subtest: render [122.443036] Dynamic subtest render: SUCCESS (0.099s) [122.454703] Starting dynamic subtest: bsd1 [123.892543] Dynamic subtest bsd1: SUCCESS (1.445s) [123.903882] Starting dynamic subtest: bsd2 [125.875392] Dynamic subtest bsd2: SUCCESS (1.980s) [125.887065] Starting dynamic subtest: blt [125.918512] Dynamic subtest blt: SUCCESS (0.043s) [125.926051] Starting dynamic subtest: vebox [127.858743] Dynamic subtest vebox: SUCCESS (1.937s) [127.861824] Subtest legacy-engines-queued: SUCCESS (5.513s) [127.959874] [008/133] (891s left) drm_read (short-buffer-block) [128.141224] Starting subtest: short-buffer-block [128.143529] Subtest short-buffer-block: SUCCESS (0.000s) [128.288333] [009/133] (891s left) gem_render_copy_redux (normal) [128.352477] Starting subtest: normal [128.606385] Subtest normal: SUCCESS (0.255s) [128.750993] [010/133] (891s left) kms_big_fb (y-tiled-32bpp-rotate-90) [128.853478] Starting subtest: y-tiled-32bpp-rotate-90 [128.857846] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [128.988671] [011/133] (890s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [129.091290] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [136.311904] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.220s) [136.481055] [012/133] (883s left) gem_exec_suspend (basic) [136.549353] Starting subtest: basic [136.551702] Starting dynamic subtest: smem [137.878300] Dynamic subtest smem: SUCCESS (1.326s) [137.881093] Subtest basic: SUCCESS (1.328s) [138.081142] [013/133] (881s left) kms_hdmi_inject (inject-audio) [138.430197] Starting subtest: inject-audio [138.702042] Subtest inject-audio: SUCCESS (0.274s) [139.288685] [014/133] (880s left) kms_cursor_crc (cursor-sliding-32x10) [139.444986] Starting subtest: cursor-sliding-32x10 [139.488991] Subtest cursor-sliding-32x10: SKIP (0.040s) [139.795434] [015/133] (880s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [139.896843] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [146.415199] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.521s) [146.574769] [016/133] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [146.674689] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [146.679255] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [146.817346] [017/133] (873s left) gem_render_copy (y-tiled-ccs-to-linear) [146.886437] Starting subtest: y-tiled-ccs-to-linear [146.891119] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [147.093370] [018/133] (873s left) kms_big_fb (4-tiled-16bpp-rotate-90) [147.214856] Starting subtest: 4-tiled-16bpp-rotate-90 [147.234346] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [147.393216] [019/133] (872s left) syncobj_timeline (transfer-timeline-point) [147.455046] Starting subtest: transfer-timeline-point [147.457317] Subtest transfer-timeline-point: SUCCESS (0.000s) [147.569579] [020/133] (872s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [147.641358] Starting subtest: invalid-multi-wait-unsubmitted-submitted [147.643366] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [147.761125] [021/133] (872s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [147.857747] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [147.859980] Starting dynamic subtest: pipe-A-eDP-1 [147.885357] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [147.898788] Starting dynamic subtest: pipe-B-eDP-1 [147.924704] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [147.934455] Starting dynamic subtest: pipe-C-eDP-1 [147.959741] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [147.968766] Starting dynamic subtest: pipe-D-eDP-1 [147.993741] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [147.998071] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [150.148330] [022/133] (870s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [152.078174] Starting subtest: dpms-mode-unset-non-lpsp [153.243511] Subtest dpms-mode-unset-non-lpsp: SKIP (1.167s) [153.632214] [023/133] (866s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [153.736599] Starting subtest: psr-rgb565-draw-mmap-wc [160.472224] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.738s) [160.606186] [024/133] (859s left) kms_chamelium_edid (vga-edid-read) [160.995387] Subtest vga-edid-read: SKIP (0.000s) [161.833281] [025/133] (858s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [161.916230] Starting subtest: yf-tiled-to-vebox-y-tiled [161.920166] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [162.120253] [026/133] (858s left) kms_flip (dpms-off-confusion) [162.218703] Starting subtest: dpms-off-confusion [162.220919] Starting dynamic subtest: A-eDP1 [170.864699] Dynamic subtest A-eDP1: SUCCESS (8.647s) [170.874471] Starting dynamic subtest: B-eDP1 [179.494645] Dynamic subtest B-eDP1: SUCCESS (8.629s) [179.504259] Starting dynamic subtest: C-eDP1 [188.108558] Dynamic subtest C-eDP1: SUCCESS (8.613s) [188.118599] Starting dynamic subtest: D-eDP1 [196.740595] Dynamic subtest D-eDP1: SUCCESS (8.631s) [196.743127] Subtest dpms-off-confusion: SUCCESS (34.526s) [197.937871] [027/133] (822s left) gem_exec_big (single) [198.011757] Starting subtest: single [200.346426] Subtest single: SUCCESS (2.332s) [200.583765] [028/133] (819s left) gem_exec_flush (basic-wb-ro-default) [200.685736] Starting subtest: basic-wb-ro-default [206.145486] Subtest basic-wb-ro-default: SUCCESS (5.461s) [206.351006] [029/133] (814s left) kms_async_flips (async-flip-with-page-flip-events-linear) [206.468806] Starting subtest: async-flip-with-page-flip-events-linear [206.856662] Starting dynamic subtest: pipe-A-eDP-1 [209.601540] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.744s) [209.964596] Starting dynamic subtest: pipe-B-eDP-1 [212.730779] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s) [213.093314] Starting dynamic subtest: pipe-C-eDP-1 [215.862611] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.775s) [216.223140] Starting dynamic subtest: pipe-D-eDP-1 [218.990135] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.774s) [218.993164] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.522s) [220.190964] [030/133] (800s left) kms_plane_scaling (planes-downscale-factor-0-75) [220.296882] Starting subtest: planes-downscale-factor-0-75 [220.299144] Starting dynamic subtest: pipe-A [220.318906] Dynamic subtest pipe-A: SKIP (0.018s) [220.331461] Starting dynamic subtest: pipe-B [220.350631] Dynamic subtest pipe-B: SKIP (0.032s) [220.360335] Starting dynamic subtest: pipe-C [220.386308] Dynamic subtest pipe-C: SKIP (0.034s) [220.396183] Starting dynamic subtest: pipe-D [220.416164] Dynamic subtest pipe-D: SKIP (0.031s) [220.419769] Subtest planes-downscale-factor-0-75: SKIP (0.117s) [220.540240] [031/133] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [220.637700] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [220.641982] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [220.779578] [032/133] (799s left) kms_properties (colorop-properties-legacy) [220.873051] Starting subtest: colorop-properties-legacy [220.875340] Starting dynamic subtest: pipe-A-eDP-1 [221.231400] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s) [221.240531] Starting dynamic subtest: pipe-B-eDP-1 [222.331262] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.100s) [222.339670] Starting dynamic subtest: pipe-C-eDP-1 [223.354660] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.021s) [223.364328] Starting dynamic subtest: pipe-D-eDP-1 [224.398857] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.042s) [224.401225] Subtest colorop-properties-legacy: SUCCESS (3.527s) [225.212360] [033/133] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [225.316284] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [225.320692] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [225.455088] [034/133] (795s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [225.556262] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [225.558586] Starting dynamic subtest: pipe-A-eDP-1 [225.579133] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [225.589076] Starting dynamic subtest: pipe-B-eDP-1 [225.608680] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [225.616844] Starting dynamic subtest: pipe-C-eDP-1 [225.636095] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [225.644314] Starting dynamic subtest: pipe-D-eDP-1 [225.663719] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [225.665962] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [227.873914] [035/133] (792s left) gem_wait (wait) [227.948624] Starting subtest: wait [227.950924] Starting dynamic subtest: all-engines [229.909760] Dynamic subtest all-engines: SUCCESS (1.959s) [229.920183] Starting dynamic subtest: rcs0 [230.955015] Dynamic subtest rcs0: SUCCESS (1.044s) [230.965633] Starting dynamic subtest: bcs0 [232.003182] Dynamic subtest bcs0: SUCCESS (1.046s) [232.013712] Starting dynamic subtest: vcs0 [233.048439] Dynamic subtest vcs0: SUCCESS (1.043s) [233.058803] Starting dynamic subtest: vcs1 [234.094532] Dynamic subtest vcs1: SUCCESS (1.044s) [234.105078] Starting dynamic subtest: vecs0 [235.141025] Dynamic subtest vecs0: SUCCESS (1.044s) [235.151756] Starting dynamic subtest: ccs0 [236.188644] Dynamic subtest ccs0: SUCCESS (1.046s) [236.191194] Subtest wait: SUCCESS (8.240s) [236.415046] [036/133] (784s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [236.520356] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [236.524710] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [236.659467] [037/133] (784s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [236.764857] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [237.843732] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.079s) [237.979689] [038/133] (782s left) gem_exec_reloc (basic-concurrent0) [238.028036] Subtest basic-concurrent0: SKIP (0.000s) [238.107701] [039/133] (782s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [238.221134] Starting subtest: yf-tiled-32bpp-rotate-180 [238.224775] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [238.337961] [040/133] (782s left) kms_lease (cursor-implicit-plane) [238.431746] Starting subtest: cursor-implicit-plane [238.433362] Starting dynamic subtest: pipe-A-eDP-1 [238.889215] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s) [238.897739] Starting dynamic subtest: pipe-B-eDP-1 [239.966830] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.076s) [239.977686] Starting dynamic subtest: pipe-C-eDP-1 [241.086924] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s) [241.095647] Starting dynamic subtest: pipe-D-eDP-1 [242.221413] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s) [242.223753] Subtest cursor-implicit-plane: SUCCESS (3.791s) [243.106875] [041/133] (777s left) gem_exec_schedule (u-semaphore-resolve) [243.189908] Starting subtest: u-semaphore-resolve [243.214245] Subtest u-semaphore-resolve: SUCCESS (0.034s) [243.585876] [042/133] (777s left) gem_exec_whisper (basic-fds-priority) [243.657777] Starting subtest: basic-fds-priority [267.479940] Subtest basic-fds-priority: SUCCESS (23.817s) [267.687253] [043/133] (753s left) i915_query (query-topology-known-pci-ids) [267.741768] Starting subtest: query-topology-known-pci-ids [267.746158] Subtest query-topology-known-pci-ids: SKIP (0.000s) [267.887472] [044/133] (753s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [267.985088] Starting subtest: yf-tiled-64bpp-rotate-90 [267.989442] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [268.110503] [045/133] (753s left) perf_pmu (idle) [268.151923] Starting subtest: idle [268.154308] Starting dynamic subtest: rcs0 [268.703032] Dynamic subtest rcs0: SUCCESS (0.547s) [268.713597] Starting dynamic subtest: bcs0 [269.218477] Dynamic subtest bcs0: SUCCESS (0.517s) [269.230637] Starting dynamic subtest: vcs0 [269.743316] Dynamic subtest vcs0: SUCCESS (0.519s) [269.753607] Starting dynamic subtest: vcs1 [270.266396] Dynamic subtest vcs1: SUCCESS (0.525s) [270.278882] Starting dynamic subtest: vecs0 [270.795731] Dynamic subtest vecs0: SUCCESS (0.526s) [270.807446] Starting dynamic subtest: ccs0 [271.327527] Dynamic subtest ccs0: SUCCESS (0.525s) [271.330104] Subtest idle: SUCCESS (3.173s) [271.465827] [046/133] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [271.565219] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [271.569268] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [271.700853] [047/133] (749s left) gem_exec_flush (basic-uc-pro-default) [271.776515] Starting subtest: basic-uc-pro-default [277.236892] Subtest basic-uc-pro-default: SUCCESS (5.463s) [277.444344] [048/133] (743s left) gem_basic (bad-close) [277.513678] Starting subtest: bad-close [277.517904] Subtest bad-close: SUCCESS (0.000s) [277.653325] [049/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [277.755125] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [277.759071] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [277.892138] [050/133] (743s left) kms_plane (pixel-format) [277.990034] Starting subtest: pixel-format [278.018568] Starting dynamic subtest: pipe-A-plane-0 [282.851228] Dynamic subtest pipe-A-plane-0: SUCCESS (4.833s) [282.861917] Starting dynamic subtest: pipe-A-plane-3 [285.129012] Dynamic subtest pipe-A-plane-3: SUCCESS (2.277s) [285.138154] Starting dynamic subtest: pipe-A-plane-5 [285.340187] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s) [286.467683] Starting dynamic subtest: pipe-B-plane-0 [291.292070] Dynamic subtest pipe-B-plane-0: SUCCESS (4.833s) [291.300925] Starting dynamic subtest: pipe-B-plane-3 [293.559034] Dynamic subtest pipe-B-plane-3: SUCCESS (2.266s) [293.570825] Starting dynamic subtest: pipe-B-plane-5 [293.769811] Dynamic subtest pipe-B-plane-5: SUCCESS (0.209s) [294.095807] Subtest pixel-format: SUCCESS (16.107s) [294.963503] [051/133] (726s left) kms_psr (fbc-psr2-no-drrs) [295.057682] Starting subtest: fbc-psr2-no-drrs [295.059977] Starting dynamic subtest: eDP-1 [295.064117] Dynamic subtest eDP-1: SKIP (0.000s) [295.068194] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [295.154307] [052/133] (726s left) gem_mmap (bad-size) [295.218488] Subtest bad-size: SKIP (0.000s) [295.274437] [053/133] (726s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [295.376324] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [295.380423] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [295.495910] [054/133] (725s left) api_intel_bb (crc32) [295.555426] Starting subtest: crc32 [295.557675] Starting dynamic subtest: rcs0-smem0 [295.848402] Dynamic subtest rcs0-smem0: SUCCESS (0.294s) [295.859708] Starting dynamic subtest: bcs0-smem0 [296.154782] Dynamic subtest bcs0-smem0: SUCCESS (0.304s) [296.165067] Starting dynamic subtest: vcs0-smem0 [296.467816] Dynamic subtest vcs0-smem0: SUCCESS (0.312s) [296.479698] Starting dynamic subtest: vcs1-smem0 [296.847110] Dynamic subtest vcs1-smem0: SUCCESS (0.375s) [296.858076] Starting dynamic subtest: vecs0-smem0 [297.173409] Dynamic subtest vecs0-smem0: SUCCESS (0.324s) [297.185265] Starting dynamic subtest: ccs0-smem0 [297.524638] Dynamic subtest ccs0-smem0: SUCCESS (0.348s) [297.527461] Subtest crc32: SUCCESS (1.973s) [297.680159] [055/133] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [297.771044] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [297.774896] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [297.892700] [056/133] (723s left) kms_psr (psr2-cursor-render) [297.984385] Starting subtest: psr2-cursor-render [297.986739] Starting dynamic subtest: eDP-1 [299.709487] Dynamic subtest eDP-1: SUCCESS (1.727s) [299.711843] Subtest psr2-cursor-render: SUCCESS (1.727s) [300.532810] [057/133] (721s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [300.625147] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [300.636314] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s) [300.773395] [058/133] (720s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [300.868398] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [300.870719] Starting dynamic subtest: pipe-A-eDP-1 [301.333420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s) [301.344161] Starting dynamic subtest: pipe-B-eDP-1 [302.780584] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.445s) [302.789057] Starting dynamic subtest: pipe-C-eDP-1 [304.129638] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.348s) [304.140604] Starting dynamic subtest: pipe-D-eDP-1 [305.458752] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s) [305.460991] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.566s) [306.675977] [059/133] (714s left) kms_dp_linktrain_fallback (dp-fallback) [306.779402] Starting subtest: dp-fallback [306.785632] Subtest dp-fallback: SKIP (0.000s) [306.876628] [060/133] (714s left) gem_readwrite (beyond-eob) [306.930556] Subtest beyond-EOB: SKIP (0.000s) [306.985398] [061/133] (714s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [307.090265] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [311.552862] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.467s) [312.763638] [062/133] (709s left) prime_vgem (basic-fence-read) [312.909081] Starting subtest: basic-fence-read [312.917760] Subtest basic-fence-read: SKIP (0.007s) [313.041313] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [313.044594] [063/133] (708s left) perf_pmu (interrupts) [313.090077] Starting subtest: interrupts [314.192890] Subtest interrupts: SUCCESS (1.103s) [314.341615] [064/133] (707s left) i915_pm_rpm (system-suspend-devices) [316.062825] Starting subtest: system-suspend-devices [323.842232] Subtest system-suspend-devices: SUCCESS (7.782s) [324.225236] [065/133] (697s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [324.335257] Starting subtest: flip-vs-dpms-on-nop-interruptible [324.337643] Starting dynamic subtest: A-eDP1 [326.207512] Dynamic subtest A-eDP1: SUCCESS (1.871s) [326.222454] Starting dynamic subtest: B-eDP1 [328.038104] Dynamic subtest B-eDP1: SUCCESS (1.828s) [328.050791] Starting dynamic subtest: C-eDP1 [329.850581] Dynamic subtest C-eDP1: SUCCESS (1.808s) [329.862216] Starting dynamic subtest: D-eDP1 [331.680740] Dynamic subtest D-eDP1: SUCCESS (1.828s) [331.683067] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.348s) [332.888834] [066/133] (689s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [332.992800] Starting subtest: crc-primary-basic-y-tiled-ccs [332.995130] Starting dynamic subtest: pipe-A-eDP-1 [333.017586] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [333.028970] Starting dynamic subtest: pipe-B-eDP-1 [333.050117] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [333.059725] Starting dynamic subtest: pipe-C-eDP-1 [333.081362] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [333.090732] Starting dynamic subtest: pipe-D-eDP-1 [333.112624] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [333.116719] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [335.236723] [067/133] (686s left) kms_color (ctm-0-75) [335.342738] Starting subtest: ctm-0-75 [335.344989] Starting dynamic subtest: pipe-A-eDP-1 [340.186654] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.843s) [340.196688] Starting dynamic subtest: pipe-B-eDP-1 [345.876078] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.688s) [345.886248] Starting dynamic subtest: pipe-C-eDP-1 [351.246306] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.369s) [351.256375] Starting dynamic subtest: pipe-D-eDP-1 [356.593577] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.346s) [356.595758] Subtest ctm-0-75: SUCCESS (21.250s) [357.433554] [068/133] (664s left) gem_mmap_offset (partial-mmap) [357.504367] Starting subtest: partial-mmap [357.506547] Starting dynamic subtest: smem0 [357.508703] Dynamic subtest smem0: SUCCESS (0.004s) [357.510627] Subtest partial-mmap: SUCCESS (0.005s) [357.652929] [069/133] (664s left) syncobj_timeline (device-signal-unordered) [357.714595] Starting subtest: device-signal-unordered [357.716937] Subtest device-signal-unordered: SUCCESS (0.000s) [357.853552] [070/133] (664s left) kms_pm_dc (dc6-psr) [358.960791] Starting subtest: dc6-psr [361.851086] Subtest dc6-psr: SUCCESS (2.888s) [362.664507] [071/133] (659s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [362.780240] Starting subtest: cursorB-vs-flipB-varying-size [362.784420] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [362.948397] [072/133] (659s left) kms_addfb_basic (no-handle) [363.014226] Starting subtest: no-handle [363.016608] Subtest no-handle: SUCCESS (0.000s) [363.169830] [073/133] (659s left) gem_pxp (create-regular-buffer) [363.299609] Starting subtest: create-regular-buffer [363.302060] Subtest create-regular-buffer: SUCCESS (0.000s) [363.426406] [074/133] (658s left) kms_flip (2x-dpms-vs-vblank-race) [363.523503] Starting subtest: 2x-dpms-vs-vblank-race [363.531236] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s) [363.682473] [075/133] (658s left) kms_psr (psr-dpms) [363.781137] Starting subtest: psr-dpms [363.783039] Starting dynamic subtest: eDP-1 [366.759604] Dynamic subtest eDP-1: SUCCESS (2.976s) [366.761590] Subtest psr-dpms: SUCCESS (2.977s) [367.671971] [076/133] (654s left) gem_lmem_swapping (massive-random) [367.714524] Subtest massive-random: SKIP (0.000s) [367.764303] [077/133] (654s left) gen9_exec_parse (bb-secure) [367.831445] Subtest bb-secure: SKIP (0.000s) [367.916418] [078/133] (654s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [368.019717] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [368.024214] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [368.163198] [079/133] (654s left) i915_suspend (fence-restore-untiled) [368.231596] Starting subtest: fence-restore-untiled [368.235720] Subtest fence-restore-untiled: SKIP (0.000s) [368.366290] [080/133] (654s left) syncobj_wait (wait-delayed-signal) [368.427055] Starting subtest: wait-delayed-signal [368.530591] Subtest wait-delayed-signal: SUCCESS (0.103s) [368.630158] [081/133] (653s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [368.731355] Starting subtest: bad-pixel-format-yf-tiled-ccs [368.733756] Starting dynamic subtest: pipe-A-eDP-1 [368.757826] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [368.770229] Starting dynamic subtest: pipe-B-eDP-1 [368.791253] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [368.800237] Starting dynamic subtest: pipe-C-eDP-1 [368.821763] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [368.833411] Starting dynamic subtest: pipe-D-eDP-1 [368.856505] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [368.861085] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s) [371.007074] [082/133] (651s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [371.108862] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [371.114501] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [371.220496] [083/133] (651s left) kms_chamelium_hpd (dp-hpd-fast) [371.607456] Subtest dp-hpd-fast: SKIP (0.000s) [372.389995] [084/133] (650s left) gem_exec_balancer (bonded-false-hang) [372.649743] Starting subtest: bonded-false-hang [372.654782] Subtest bonded-false-hang: SKIP (0.000s) [372.768897] [085/133] (649s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [372.864403] Starting subtest: crc-primary-suspend-yf-tiled-ccs [372.866564] Starting dynamic subtest: pipe-A-eDP-1 [372.875296] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [372.885618] Starting dynamic subtest: pipe-B-eDP-1 [372.894211] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [372.903256] Starting dynamic subtest: pipe-C-eDP-1 [372.911194] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [372.919716] Starting dynamic subtest: pipe-D-eDP-1 [372.927772] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [372.931666] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s) [375.124434] [086/133] (647s left) gem_exec_fence (syncobj-timeline-invalid-flags) [375.674683] Starting subtest: syncobj-timeline-invalid-flags [375.677425] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [377.049947] [087/133] (645s left) kms_plane_cursor (overlay) [377.156160] Starting subtest: overlay [377.160353] Starting dynamic subtest: pipe-A-eDP-1-size-64 [379.633464] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.477s) [379.694898] Starting dynamic subtest: pipe-A-eDP-1-size-128 [382.168725] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.481s) [382.229650] Starting dynamic subtest: pipe-A-eDP-1-size-256 [384.647471] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.426s) [384.996915] Starting dynamic subtest: pipe-B-eDP-1-size-64 [388.225768] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.239s) [388.289729] Starting dynamic subtest: pipe-B-eDP-1-size-128 [390.869601] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.592s) [390.932570] Starting dynamic subtest: pipe-B-eDP-1-size-256 [393.417119] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.493s) [393.764116] Starting dynamic subtest: pipe-C-eDP-1-size-64 [396.547464] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.793s) [396.589042] Starting dynamic subtest: pipe-C-eDP-1-size-128 [398.692363] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.113s) [398.730915] Starting dynamic subtest: pipe-C-eDP-1-size-256 [400.836257] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.114s) [401.167174] Starting dynamic subtest: pipe-D-eDP-1-size-64 [403.966902] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.809s) [404.004502] Starting dynamic subtest: pipe-D-eDP-1-size-128 [406.144144] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.146s) [406.183173] Starting dynamic subtest: pipe-D-eDP-1-size-256 [408.255250] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.080s) [408.576855] Subtest overlay: SUCCESS (31.418s) [409.446484] [088/133] (613s left) gem_ctx_param (basic-default) [409.510972] Starting subtest: basic-default [409.513298] Subtest basic-default: SUCCESS (0.000s) [409.611219] [089/133] (613s left) api_intel_allocator (two-level-inception-interruptible) [409.665481] Starting subtest: two-level-inception-interruptible [415.067531] Subtest two-level-inception-interruptible: SUCCESS (5.403s) [415.232284] [090/133] (607s left) kms_dsc (dsc-with-bpc-formats) [415.346932] Starting subtest: dsc-with-bpc-formats [415.460582] Subtest dsc-with-bpc-formats: SKIP (0.003s) [415.502220] [091/133] (607s left) kms_cursor_crc (cursor-alpha-opaque) [415.604531] Starting subtest: cursor-alpha-opaque [415.606797] Starting dynamic subtest: pipe-A-eDP-1 [416.224765] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s) [416.235080] Starting dynamic subtest: pipe-D-eDP-1 [417.475358] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.250s) [417.477903] Subtest cursor-alpha-opaque: SUCCESS (1.871s) [418.301190] [092/133] (604s left) syncobj_timeline (multi-wait-all-signaled) [418.377681] Starting subtest: multi-wait-all-signaled [418.380016] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [418.514459] [093/133] (604s left) i915_drm_fdinfo (isolation) [418.555913] Starting subtest: isolation [418.558273] Starting dynamic subtest: rcs0 [418.603661] Dynamic subtest rcs0: SKIP (0.046s) [418.616606] Starting dynamic subtest: bcs0 [418.620835] Dynamic subtest bcs0: SKIP (0.001s) [418.630648] Starting dynamic subtest: vcs0 [418.635154] Dynamic subtest vcs0: SKIP (0.000s) [418.644222] Starting dynamic subtest: vcs1 [418.648284] Dynamic subtest vcs1: SKIP (0.000s) [418.657590] Starting dynamic subtest: vecs0 [418.661668] Dynamic subtest vecs0: SKIP (0.000s) [418.671032] Starting dynamic subtest: ccs0 [418.675179] Dynamic subtest ccs0: SKIP (0.000s) [418.679251] Subtest isolation: SKIP (0.053s) [418.721277] [094/133] (604s left) kms_flip_scaled_crc (flip-p016-linear-to-p016-linear-reflect-x) [418.824417] Starting subtest: flip-P016-linear-to-P016-linear-reflect-x [418.826605] Starting dynamic subtest: pipe-A-default-mode [419.939663] Dynamic subtest pipe-A-default-mode: SKIP (1.111s) [419.944290] Subtest flip-P016-linear-to-P016-linear-reflect-x: SKIP (1.113s) [420.138254] [095/133] (603s left) gem_ctx_isolation (preservation-s3) [420.208842] Starting subtest: preservation-S3 [420.211166] Starting dynamic subtest: rcs0 [435.958137] Dynamic subtest rcs0: SUCCESS (1.354s) [435.968967] Starting dynamic subtest: bcs0 [452.000172] Dynamic subtest bcs0: SUCCESS (1.367s) [452.011811] Starting dynamic subtest: vcs0 [467.973631] Dynamic subtest vcs0: SUCCESS (3.041s) [467.984985] Starting dynamic subtest: vcs1 [485.991422] Dynamic subtest vcs1: SUCCESS (4.862s) [486.002432] Starting dynamic subtest: vecs0 [503.992711] Dynamic subtest vecs0: SUCCESS (4.842s) [504.004698] Starting dynamic subtest: ccs0 [521.990320] Dynamic subtest ccs0: SUCCESS (3.049s) [521.992216] Subtest preservation-S3: SUCCESS (18.521s) [522.268221] [096/133] (500s left) gem_eio (reset-stress) [522.516291] Starting subtest: reset-stress [522.518866] Starting dynamic subtest: render [527.823522] Dynamic subtest render: SUCCESS (5.153s) [527.836553] Starting dynamic subtest: bsd1 [546.321478] Dynamic subtest bsd1: SUCCESS (18.350s) [546.339475] Starting dynamic subtest: bsd2 [564.297216] Dynamic subtest bsd2: SUCCESS (17.960s) [564.314276] Starting dynamic subtest: blt [564.318268] Dynamic subtest blt: SKIP (0.000s) [564.328794] Starting dynamic subtest: vebox [582.294897] Dynamic subtest vebox: SUCCESS (17.986s) [582.296856] Subtest reset-stress: SUCCESS (59.454s) [583.798765] [097/133] (439s left) gem_softpin (evict-snoop-interruptible) [583.882679] Starting subtest: evict-snoop-interruptible [583.886655] Subtest evict-snoop-interruptible: SKIP (0.000s) [584.038960] [098/133] (439s left) i915_module_load (reload-no-display) [584.082529] Starting subtest: reload-no-display [589.754877] Subtest reload-no-display: SUCCESS (5.673s) [589.784380] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [589.785142] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [589.788347] [099/133] (433s left) kms_flip (2x-flip-vs-modeset) [591.383617] Starting subtest: 2x-flip-vs-modeset [591.393796] Subtest 2x-flip-vs-modeset: SKIP (0.012s) [591.505322] [FACT kms_flip (2x-flip-vs-modeset)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [591.506722] [FACT kms_flip (2x-flip-vs-modeset)] new: kernel.kmod_is_loaded.i915: true [591.510466] [100/133] (431s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [591.616157] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [591.618246] Starting dynamic subtest: pipe-A-default-mode [592.637371] Dynamic subtest pipe-A-default-mode: SKIP (1.017s) [592.642083] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (1.019s) [592.983251] [101/133] (430s left) kms_content_protection (type1) [593.149251] Starting subtest: type1 [593.153961] Subtest type1: SKIP (0.000s) [593.312782] [102/133] (430s left) kms_big_fb (4-tiled-16bpp-rotate-180) [593.419855] Starting subtest: 4-tiled-16bpp-rotate-180 [594.631515] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.211s) [594.790227] [103/133] (428s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [594.906131] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [594.909610] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [595.047818] [104/133] (428s left) gem_ppgtt (flink-and-close-vma-leak) [595.109487] Starting subtest: flink-and-close-vma-leak [595.153108] Subtest flink-and-close-vma-leak: SUCCESS (0.044s) [595.297293] [105/133] (428s left) syncobj_wait (signal) [595.352233] Starting subtest: signal [595.353906] Subtest signal: SUCCESS (0.000s) [595.472247] [106/133] (428s left) kms_cursor_crc (cursor-rapid-movement-128x128) [595.676201] Starting subtest: cursor-rapid-movement-128x128 [595.678179] Starting dynamic subtest: pipe-A-eDP-1 [596.255500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s) [596.288692] Starting dynamic subtest: pipe-D-eDP-1 [597.704166] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.418s) [597.706430] Subtest cursor-rapid-movement-128x128: SUCCESS (2.027s) [598.604356] [107/133] (425s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [603.661093] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [603.663420] Starting dynamic subtest: pipe-A-eDP-1 [604.454387] Dynamic subtest pipe-A-eDP-1: SKIP (0.787s) [604.464880] Starting dynamic subtest: pipe-B-eDP-1 [605.583263] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s) [605.587716] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.920s) [606.883276] [108/133] (416s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [606.995050] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [613.470579] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.474s) [613.631150] [109/133] (410s left) kms_vblank (query-forked-busy) [613.725580] Starting subtest: query-forked-busy [613.727816] Starting dynamic subtest: pipe-A-eDP-1 [615.610904] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s) [615.625867] Starting dynamic subtest: pipe-D-eDP-1 [618.145534] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.532s) [618.147731] Subtest query-forked-busy: SUCCESS (4.417s) [618.972998] [110/133] (404s left) syncobj_timeline (invalid-transfer-non-existent-point) [619.033945] Starting subtest: invalid-transfer-non-existent-point [619.036278] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [619.154189] [111/133] (404s left) kms_big_fb (x-tiled-16bpp-rotate-0) [619.273118] Starting subtest: x-tiled-16bpp-rotate-0 [620.484304] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.211s) [620.655478] [112/133] (403s left) kms_psr (fbc-psr-primary-blt) [620.750777] Starting subtest: fbc-psr-primary-blt [620.752649] Starting dynamic subtest: eDP-1 [620.756135] Dynamic subtest eDP-1: SKIP (0.000s) [620.759629] Subtest fbc-psr-primary-blt: SKIP (0.001s) [620.845263] [113/133] (403s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [620.904701] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [621.014403] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.108s) [621.125266] [114/133] (402s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [621.231799] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [621.235993] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [621.360186] [115/133] (402s left) gem_exec_reloc (basic-cpu-active) [621.431453] Subtest basic-cpu-active: SKIP (0.000s) [621.519789] [116/133] (402s left) perf (rc6-disable) [621.680163] Starting subtest: rc6-disable [621.860153] Subtest rc6-disable: SUCCESS (0.180s) [621.909972] [117/133] (402s left) gem_ctx_shared (q-independent) [621.974866] Starting subtest: Q-independent [621.977339] Starting dynamic subtest: rcs0 [622.039145] Dynamic subtest rcs0: SUCCESS (0.064s) [622.052671] Starting dynamic subtest: vcs0 [622.090068] Dynamic subtest vcs0: SUCCESS (0.049s) [622.101028] Starting dynamic subtest: vcs1 [622.129209] Dynamic subtest vcs1: SUCCESS (0.038s) [622.141470] Starting dynamic subtest: vecs0 [622.167548] Dynamic subtest vecs0: SUCCESS (0.038s) [622.178079] Starting dynamic subtest: ccs0 [622.210035] Dynamic subtest ccs0: SUCCESS (0.042s) [622.212018] Subtest Q-independent: SUCCESS (0.236s) [623.869009] [118/133] (400s left) perf (non-zero-reason) [623.981577] Starting subtest: non-zero-reason [623.983858] Starting dynamic subtest: 0-rcs0 [629.273699] Dynamic subtest 0-rcs0: SUCCESS (5.291s) [629.284523] Starting dynamic subtest: 1-vecs0 [633.133362] Dynamic subtest 1-vecs0: SUCCESS (3.860s) [633.136592] Subtest non-zero-reason: SUCCESS (9.152s) [633.175686] [119/133] (391s left) kms_psr (pr-dpms) [633.277455] Starting subtest: pr-dpms [633.281707] Subtest pr-dpms: SKIP (0.000s) [633.369300] [120/133] (390s left) kms_rotation_crc (primary-rotation-180) [633.472057] Starting subtest: primary-rotation-180 [640.337835] Subtest primary-rotation-180: SUCCESS (6.868s) [641.565047] [121/133] (382s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [641.674485] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [648.954723] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.283s) [649.126979] [122/133] (375s left) gem_create (create-size-update) [649.188820] Starting subtest: create-size-update [649.190743] Subtest create-size-update: SUCCESS (0.000s) [649.435548] [123/133] (374s left) prime_vgem (basic-fence-blt) [649.512258] Starting subtest: basic-fence-blt [649.593901] Subtest basic-fence-blt: SUCCESS (0.082s) [649.746630] [124/133] (374s left) kms_getfb (getfb2-into-addfb2) [649.846212] Starting subtest: getfb2-into-addfb2 [649.848382] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [649.974936] [125/133] (374s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [650.098994] Starting subtest: verify-pxp-execution-after-suspend-resume [657.882724] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.783s) [658.037265] [126/133] (366s left) syncobj_basic (bad-pad-fd-to-handle) [658.115980] Starting subtest: bad-pad-fd-to-handle [658.118346] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [658.247571] [127/133] (366s left) dmabuf_sync_file (export-before-signal) [658.297149] Starting subtest: export-before-signal [658.299478] Subtest export-before-signal: SUCCESS (0.001s) [658.381085] [128/133] (366s left) kms_flip (2x-flip-vs-panning-vs-hang) [658.475476] Starting subtest: 2x-flip-vs-panning-vs-hang [658.484808] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s) [658.590036] [129/133] (366s left) gem_softpin (allocator-nopin-reserve) [658.650220] Starting subtest: allocator-nopin-reserve [658.754453] Subtest allocator-nopin-reserve: SUCCESS (0.102s) [658.932829] [130/133] (365s left) kms_pipe_crc_basic (read-crc-frame-sequence) [659.028426] Starting subtest: read-crc-frame-sequence [659.030740] Starting dynamic subtest: pipe-A-eDP-1 [659.737432] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s) [659.748442] Starting dynamic subtest: pipe-B-eDP-1 [661.098605] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.360s) [661.110133] Starting dynamic subtest: pipe-C-eDP-1 [662.408387] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.306s) [662.419082] Starting dynamic subtest: pipe-D-eDP-1 [663.713468] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.305s) [663.715847] Subtest read-crc-frame-sequence: SUCCESS (4.685s) [664.592550] [131/133] (360s left) kms_frontbuffer_tracking (pipe-fbc-rte) [664.684484] Starting subtest: pipe-fbc-rte [664.691204] Starting dynamic subtest: pipe-B-eDP-1 [670.151001] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.468s) [670.158115] Subtest pipe-fbc-rte: SUCCESS (5.470s) [672.506664] [132/133] (352s left) kms_addfb_basic (too-wide) [672.608759] Starting subtest: too-wide [672.610946] Subtest too-wide: SUCCESS (0.000s) [672.747445] [133/133] (352s left) gem_exec_schedule (pi-shared-iova) [672.934781] Starting subtest: pi-shared-iova [672.936706] Starting dynamic subtest: rcs0 [673.006341] Dynamic subtest rcs0: SUCCESS (0.074s) [673.017406] Starting dynamic subtest: vcs0 [673.067781] Dynamic subtest vcs0: SUCCESS (0.061s) [673.077734] Starting dynamic subtest: vcs1 [673.120683] Dynamic subtest vcs1: SUCCESS (0.051s) [673.133215] Starting dynamic subtest: vecs0 [673.179064] Dynamic subtest vecs0: SUCCESS (0.058s) [673.188891] Starting dynamic subtest: ccs0 [673.234860] Dynamic subtest ccs0: SUCCESS (0.055s) [673.237214] Subtest pi-shared-iova: SUCCESS (0.303s) [674.876173] Closing watchdogs results: parsing output: 0/ for test: syncobj_basic results: parsing output: 1/ for test: kms_psr2_sf results: parsing output: 2/ for test: gem_ccs results: parsing output: 3/ for test: kms_sequence results: parsing output: 4/ for test: sysfs_preempt_timeout results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_ctx_persistence results: parsing output: 7/ for test: drm_read results: parsing output: 8/ for test: gem_render_copy_redux results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_exec_suspend results: parsing output: 12/ for test: kms_hdmi_inject results: parsing output: 13/ for test: kms_cursor_crc results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_render_copy results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: syncobj_timeline results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: kms_pm_rpm results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_chamelium_edid results: parsing output: 24/ for test: gem_render_copy results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: gem_exec_big results: parsing output: 27/ for test: gem_exec_flush results: parsing output: 28/ for test: kms_async_flips results: parsing output: 29/ for test: kms_plane_scaling results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_properties results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_ccs results: parsing output: 34/ for test: gem_wait results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: gem_exec_reloc results: parsing output: 38/ for test: kms_big_fb results: parsing output: 39/ for test: kms_lease results: parsing output: 40/ for test: gem_exec_schedule results: parsing output: 41/ for test: gem_exec_whisper results: parsing output: 42/ for test: i915_query results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: perf_pmu results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_exec_flush results: parsing output: 47/ for test: gem_basic results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_plane results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: gem_mmap results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: api_intel_bb results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_psr results: parsing output: 56/ for test: kms_flip results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: kms_dp_linktrain_fallback results: parsing output: 59/ for test: gem_readwrite results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: prime_vgem results: parsing output: 62/ for test: perf_pmu results: parsing output: 63/ for test: i915_pm_rpm results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_ccs results: parsing output: 66/ for test: kms_color results: parsing output: 67/ for test: gem_mmap_offset results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: kms_pm_dc results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: gem_pxp results: parsing output: 73/ for test: kms_flip results: parsing output: 74/ for test: kms_psr results: parsing output: 75/ for test: gem_lmem_swapping results: parsing output: 76/ for test: gen9_exec_parse results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: i915_suspend results: parsing output: 79/ for test: syncobj_wait results: parsing output: 80/ for test: kms_ccs results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_chamelium_hpd results: parsing output: 83/ for test: gem_exec_balancer results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: gem_exec_fence results: parsing output: 86/ for test: kms_plane_cursor results: parsing output: 87/ for test: gem_ctx_param results: parsing output: 88/ for test: api_intel_allocator results: parsing output: 89/ for test: kms_dsc results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: i915_drm_fdinfo results: parsing output: 93/ for test: kms_flip_scaled_crc results: parsing output: 94/ for test: gem_ctx_isolation results: parsing output: 95/ for test: gem_eio results: parsing output: 96/ for test: gem_softpin results: parsing output: 97/ for test: i915_module_load results: parsing output: 98/ for test: kms_flip results: parsing output: 99/ for test: kms_flip_scaled_crc results: parsing output: 100/ for test: kms_content_protection results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: gem_ppgtt results: parsing output: 104/ for test: syncobj_wait results: parsing output: 105/ for test: kms_cursor_crc results: parsing output: 106/ for test: kms_psr2_sf results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_vblank results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: syncobj_timeline results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: perf results: parsing output: 116/ for test: gem_ctx_shared results: parsing output: 117/ for test: perf results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_rotation_crc results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: gem_create results: parsing output: 122/ for test: prime_vgem results: parsing output: 123/ for test: kms_getfb results: parsing output: 124/ for test: gem_pxp results: parsing output: 125/ for test: syncobj_basic results: parsing output: 126/ for test: dmabuf_sync_file results: parsing output: 127/ for test: kms_flip results: parsing output: 128/ for test: gem_softpin results: parsing output: 129/ for test: kms_pipe_crc_basic results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_addfb_basic results: parsing output: 132/ for test: gem_exec_schedule Done.