[57.313212] Initializing watchdogs [57.313263] /dev/watchdog0 [57.325959] [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.329809] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.332045] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.335383] [001/131] (960s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [57.500210] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc [57.503012] Starting dynamic subtest: pipe-A-eDP-1 [57.527124] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [57.534844] Starting dynamic subtest: pipe-B-eDP-1 [57.557124] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [57.563252] Starting dynamic subtest: pipe-C-eDP-1 [57.585704] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [57.592104] Starting dynamic subtest: pipe-D-eDP-1 [57.615314] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [57.619823] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.002s) [59.685996] [002/131] (958s left) kms_addfb_basic (addfb25-y-tiled-legacy) [59.784903] Starting subtest: addfb25-y-tiled-legacy [59.787114] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [59.891859] [003/131] (958s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [59.984045] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [59.986455] Starting dynamic subtest: pipe-A-eDP-1 [60.010505] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [60.018644] Starting dynamic subtest: pipe-B-eDP-1 [60.041210] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [60.048530] Starting dynamic subtest: pipe-C-eDP-1 [60.071496] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [60.079069] Starting dynamic subtest: pipe-D-eDP-1 [60.102050] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [60.106272] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.002s) [62.170109] [004/131] (955s left) kms_psr (fbc-psr2-sprite-render) [62.276457] Starting subtest: fbc-psr2-sprite-render [62.278842] Starting dynamic subtest: eDP-1 [62.283176] Dynamic subtest eDP-1: SKIP (0.000s) [62.287427] Subtest fbc-psr2-sprite-render: SKIP (0.000s) [62.349580] [005/131] (955s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [62.451043] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [62.453490] Starting dynamic subtest: pipe-A-default-mode [63.626935] Dynamic subtest pipe-A-default-mode: SKIP (1.163s) [63.631584] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.164s) [63.782479] [006/131] (954s left) drm_fdinfo (virtual-idle) [63.824812] Starting subtest: virtual-idle [66.923501] Subtest virtual-idle: SUCCESS (3.080s) [66.993661] [007/131] (951s left) gem_ctx_exec (basic) [67.055680] Starting subtest: basic [67.065770] Subtest basic: SUCCESS (0.010s) [67.175097] [008/131] (950s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [67.236599] Starting subtest: y-tiled-ccs-to-y-tiled [67.241227] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [67.410766] [009/131] (950s left) sysfs_heartbeat_interval (nopreempt) [67.473630] Starting subtest: nopreempt [67.476053] Starting dynamic subtest: vecs0 [76.925116] Dynamic subtest vecs0: SUCCESS (9.426s) [76.934922] Starting dynamic subtest: ccs0 [80.766870] Dynamic subtest ccs0: SUCCESS (3.841s) [80.777016] Starting dynamic subtest: vcs0 [89.927691] Dynamic subtest vcs0: SUCCESS (9.148s) [89.935953] Starting dynamic subtest: bcs0 [93.741462] Dynamic subtest bcs0: SUCCESS (3.812s) [93.750849] Starting dynamic subtest: rcs0 [97.610250] Dynamic subtest rcs0: SUCCESS (3.867s) [97.619397] Starting dynamic subtest: vcs1 [106.954048] Dynamic subtest vcs1: SUCCESS (9.336s) [106.956841] Subtest nopreempt: SUCCESS (39.433s) [107.019725] [010/131] (911s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [112.018566] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [112.023595] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s) [112.864821] [011/131] (905s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [112.951021] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [112.953330] Starting dynamic subtest: pipe-A-default-mode [113.238597] Dynamic subtest pipe-A-default-mode: SKIP (0.283s) [113.243173] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.284s) [114.091776] [012/131] (904s left) kms_cursor_crc (cursor-offscreen-max-size) [114.370411] Starting subtest: cursor-offscreen-max-size [114.377302] Subtest cursor-offscreen-max-size: SKIP (0.000s) [114.489234] [013/131] (903s left) kms_plane (pixel-format-source-clamping) [114.591048] Starting subtest: pixel-format-source-clamping [114.627751] Starting dynamic subtest: pipe-A-plane-0 [119.339577] Dynamic subtest pipe-A-plane-0: SUCCESS (4.711s) [119.347549] Starting dynamic subtest: pipe-A-plane-3 [121.607272] Dynamic subtest pipe-A-plane-3: SUCCESS (2.266s) [121.613812] Starting dynamic subtest: pipe-A-plane-5 [121.615758] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s) [122.689810] Starting dynamic subtest: pipe-B-plane-0 [127.361818] Dynamic subtest pipe-B-plane-0: SUCCESS (4.678s) [127.368524] Starting dynamic subtest: pipe-B-plane-3 [129.607092] Dynamic subtest pipe-B-plane-3: SUCCESS (2.244s) [129.613929] Starting dynamic subtest: pipe-B-plane-5 [129.615836] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s) [129.927925] Subtest pixel-format-source-clamping: SUCCESS (15.333s) [130.761226] [014/131] (887s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [130.887555] Starting subtest: cursorA-vs-flipB-atomic [130.892062] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [131.035238] [015/131] (887s left) kms_big_fb (x-tiled-16bpp-rotate-90) [131.148435] Starting subtest: x-tiled-16bpp-rotate-90 [131.169887] Subtest x-tiled-16bpp-rotate-90: SKIP (0.021s) [131.299089] [016/131] (887s left) gem_exec_schedule (u-semaphore-noskip) [131.379091] Starting subtest: u-semaphore-noskip [131.775352] Subtest u-semaphore-noskip: SUCCESS (0.402s) [132.119129] [017/131] (886s left) syncobj_timeline (32bits-limit) [132.186689] Starting subtest: 32bits-limit [132.189345] Subtest 32bits-limit: SUCCESS (0.001s) [132.295427] [018/131] (886s left) gem_linear_blits (interruptible) [132.667076] Starting subtest: interruptible [137.389905] Subtest interruptible: SUCCESS (4.721s) [137.546993] [019/131] (880s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [137.705151] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [137.709281] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [137.809991] [020/131] (880s left) kms_psr (psr2-primary-page-flip) [137.904322] Starting subtest: psr2-primary-page-flip [137.906705] Starting dynamic subtest: eDP-1 [139.645944] Dynamic subtest eDP-1: SUCCESS (1.740s) [139.648457] Subtest psr2-primary-page-flip: SUCCESS (1.741s) [140.512680] [021/131] (878s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [140.901399] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [141.716306] [022/131] (876s left) kms_dirtyfb (default-dirtyfb-ioctl) [141.819119] Starting subtest: default-dirtyfb-ioctl [141.821571] Starting dynamic subtest: A-eDP-1 [143.439712] Dynamic subtest A-eDP-1: SUCCESS (1.619s) [143.442237] Subtest default-dirtyfb-ioctl: SUCCESS (1.620s) [144.265406] [023/131] (874s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [144.333035] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [144.335373] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [144.442265] [024/131] (874s left) prime_vgem (coherency-blt) [144.584746] Starting subtest: coherency-blt [145.598462] Subtest coherency-blt: SUCCESS (1.012s) [145.728290] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true [145.731301] [025/131] (873s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [145.830927] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [145.834930] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [145.926256] [026/131] (872s left) kms_prop_blob (blob-prop-lifetime) [145.991391] Starting subtest: blob-prop-lifetime [145.993803] Subtest blob-prop-lifetime: SUCCESS (0.001s) [146.094225] [027/131] (872s left) drm_fdinfo (busy-idle) [146.133075] Starting subtest: busy-idle [146.135295] Starting dynamic subtest: rcs0 [146.173273] Dynamic subtest rcs0: SKIP (0.037s) [146.182785] Starting dynamic subtest: bcs0 [146.186743] Dynamic subtest bcs0: SKIP (0.000s) [146.194067] Starting dynamic subtest: vcs0 [146.198306] Dynamic subtest vcs0: SKIP (0.000s) [146.205044] Starting dynamic subtest: vcs1 [146.208987] Dynamic subtest vcs1: SKIP (0.000s) [146.215644] Starting dynamic subtest: vecs0 [146.219608] Dynamic subtest vecs0: SKIP (0.000s) [146.226167] Starting dynamic subtest: ccs0 [146.230066] Dynamic subtest ccs0: SKIP (0.000s) [146.233970] Subtest busy-idle: SKIP (0.041s) [146.262146] [028/131] (872s left) gem_gpgpu_fill (offset-16x16) [146.317942] Starting subtest: offset-16x16 [146.323052] Subtest offset-16x16: SUCCESS (0.007s) [146.449798] [029/131] (872s left) kms_pm_dc (dc5-psr) [147.549308] Starting subtest: dc5-psr [150.435469] Subtest dc5-psr: SUCCESS (2.886s) [151.286393] [030/131] (867s left) gem_pxp (fail-invalid-protected-context) [151.416246] Starting subtest: fail-invalid-protected-context [151.418629] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [151.519423] [031/131] (867s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [151.624778] Starting subtest: crc-primary-basic-y-tiled-ccs [151.627083] Starting dynamic subtest: pipe-A-eDP-1 [151.650440] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [151.658186] Starting dynamic subtest: pipe-B-eDP-1 [151.679450] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [151.686886] Starting dynamic subtest: pipe-C-eDP-1 [151.709358] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [151.718538] Starting dynamic subtest: pipe-D-eDP-1 [151.740829] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [151.744979] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.004s) [153.739203] [032/131] (865s left) gem_render_copy (yf-tiled-ccs-to-linear) [153.804623] Starting subtest: yf-tiled-ccs-to-linear [153.808963] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [153.981168] [033/131] (865s left) core_setmaster_vs_auth [154.165894] [034/131] (864s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [154.222030] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [154.224887] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [154.320370] [035/131] (864s left) vgem_basic (dmabuf-fence-before) [154.366244] Starting subtest: dmabuf-fence-before [154.368373] Subtest dmabuf-fence-before: SUCCESS (0.001s) [154.416164] [036/131] (864s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [154.521592] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [154.526076] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [154.624688] [037/131] (864s left) kms_big_fb (linear-16bpp-rotate-180) [154.722555] Starting subtest: linear-16bpp-rotate-180 [156.144436] Subtest linear-16bpp-rotate-180: SUCCESS (1.423s) [156.274428] [038/131] (862s left) syncobj_timeline (wait-all-interrupted) [156.331783] Starting subtest: wait-all-interrupted [156.432382] Subtest wait-all-interrupted: SUCCESS (0.101s) [156.499565] [039/131] (862s left) gem_exec_reloc (basic-cpu-active) [156.558161] Subtest basic-cpu-active: SKIP (0.000s) [156.620126] [040/131] (862s left) gem_ctx_param (non-root-set) [156.673509] Starting subtest: non-root-set [156.693082] Subtest non-root-set: SUCCESS (0.020s) [156.777283] [041/131] (862s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [156.885826] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [156.889272] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [156.992801] [042/131] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [157.094925] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [157.098241] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [157.203373] [043/131] (862s left) gem_userptr_blits (input-checking) [157.274942] Starting subtest: input-checking [157.276605] Subtest input-checking: SUCCESS (0.000s) [157.412989] [044/131] (861s left) api_intel_allocator (fork-simple-once) [157.469778] Starting subtest: fork-simple-once [157.486756] Subtest fork-simple-once: SUCCESS (0.018s) [157.612843] [045/131] (861s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [157.710638] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [157.712541] Starting dynamic subtest: pipe-A-eDP-1 [158.993189] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.281s) [159.002307] Starting dynamic subtest: pipe-B-eDP-1 [161.293135] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.299s) [161.301704] Starting dynamic subtest: pipe-C-eDP-1 [163.598697] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.305s) [163.607488] Starting dynamic subtest: pipe-D-eDP-1 [165.918685] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.319s) [165.920855] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.208s) [167.030374] [046/131] (852s left) syncobj_timeline (signal) [167.100665] Starting subtest: signal [167.103016] Subtest signal: SUCCESS (0.000s) [167.193340] [047/131] (852s left) perf (gen12-group-concurrent-oa-buffer-read) [167.318014] Starting subtest: gen12-group-concurrent-oa-buffer-read [177.371061] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.052s) [177.411028] [048/131] (842s left) gem_create (create-ext-set-pat) [177.581793] Starting subtest: create-ext-set-pat [177.584357] Subtest create-ext-set-pat: SUCCESS (0.001s) [177.684716] [049/131] (841s left) gem_exec_reloc (basic-gtt) [177.745069] Subtest basic-gtt: SKIP (0.000s) [177.826332] [050/131] (841s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [177.936556] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [182.525091] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.591s) [182.629137] [051/131] (836s left) gem_userptr_blits (set-cache-level) [182.693513] Starting subtest: set-cache-level [182.698334] Subtest set-cache-level: SKIP (0.000s) [182.817059] [052/131] (836s left) gem_exec_big (single) [182.884094] Starting subtest: single [190.599582] Subtest single: SUCCESS (7.697s) [191.303253] [053/131] (828s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [191.459329] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [191.463515] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [191.557640] [054/131] (828s left) kms_getfb (getfb2-handle-closed) [191.628771] Starting subtest: getfb2-handle-closed [191.631099] Subtest getfb2-handle-closed: SUCCESS (0.000s) [191.737402] [055/131] (827s left) kms_vblank (query-idle-hang) [191.844226] Starting subtest: query-idle-hang [191.846473] Starting dynamic subtest: pipe-A-eDP-1 [218.656148] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.808s) [218.669537] Starting dynamic subtest: pipe-D-eDP-1 [233.698048] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.037s) [233.700482] Subtest query-idle-hang: SUCCESS (41.849s) [234.478189] [056/131] (785s left) gem_exec_reloc (basic-write-read-noreloc) [234.551017] Subtest basic-write-read-noreloc: SKIP (0.000s) [234.627698] [057/131] (785s left) syncobj_timeline (invalid-signal-illegal-handle) [234.679324] Starting subtest: invalid-signal-illegal-handle [234.681693] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [234.783499] [058/131] (785s left) gem_exec_schedule (promotion) [234.860398] Starting subtest: promotion [234.862427] Starting dynamic subtest: rcs0 [234.963936] Dynamic subtest rcs0: SUCCESS (0.111s) [234.974221] Starting dynamic subtest: vcs0 [235.041715] Dynamic subtest vcs0: SUCCESS (0.078s) [235.049385] Starting dynamic subtest: vcs1 [235.122155] Dynamic subtest vcs1: SUCCESS (0.080s) [235.133473] Starting dynamic subtest: vecs0 [235.197635] Dynamic subtest vecs0: SUCCESS (0.075s) [235.208812] Starting dynamic subtest: ccs0 [235.288408] Dynamic subtest ccs0: SUCCESS (0.090s) [235.290797] Subtest promotion: SUCCESS (0.436s) [237.020351] [059/131] (782s left) kms_lease (lease-get) [237.128084] Starting subtest: lease-get [237.130335] Starting dynamic subtest: pipe-A-eDP-1 [237.132760] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [237.140621] Starting dynamic subtest: pipe-B-eDP-1 [237.142540] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [237.149722] Starting dynamic subtest: pipe-C-eDP-1 [237.151715] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [237.158697] Starting dynamic subtest: pipe-D-eDP-1 [237.160675] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [237.162688] Subtest lease-get: SUCCESS (0.008s) [237.239477] [060/131] (782s left) gem_exec_gttfill (basic) [237.303434] Starting subtest: basic [241.982246] Subtest basic: SUCCESS (4.677s) [242.163142] [061/131] (777s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [242.264751] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [242.375514] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.109s) [242.446056] [062/131] (777s left) gem_exec_fence (submit67) [242.630229] Starting subtest: submit67 [242.635184] Subtest submit67: SKIP (0.000s) [244.043548] [063/131] (775s left) kms_psr2_sf (psr2-cursor-plane-update-sf) [249.027150] Starting subtest: psr2-cursor-plane-update-sf [249.029717] Starting dynamic subtest: pipe-A-eDP-1 [250.333844] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.303s) [250.346619] Starting dynamic subtest: pipe-B-eDP-1 [251.660596] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.326s) [251.663057] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.633s) [252.521204] [064/131] (767s left) i915_pciid [252.673481] [065/131] (767s left) gem_mmap_gtt (cpuset-big-copy-odd) [252.724248] Subtest cpuset-big-copy-odd: SKIP (0.000s) [252.783351] [066/131] (767s left) kms_fbcon_fbt (psr) [252.841732] Starting subtest: psr [258.174058] Subtest psr: SUCCESS (5.330s) [258.229997] [067/131] (761s left) kms_joiner (invalid-modeset-force-ultra-joiner) [258.334821] Starting subtest: invalid-modeset-force-ultra-joiner [258.339233] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [258.393389] [068/131] (761s left) kms_busy (basic) [258.508202] Starting subtest: basic [258.510511] Starting dynamic subtest: flip [259.135884] Dynamic subtest flip: SUCCESS (0.626s) [259.146076] Starting dynamic subtest: modeset [262.504664] Dynamic subtest modeset: SUCCESS (3.367s) [262.507104] Subtest basic: SUCCESS (3.995s) [263.300129] [069/131] (756s left) gem_eio (in-flight-contexts-1us) [263.526342] Starting subtest: in-flight-contexts-1us [273.924220] Subtest in-flight-contexts-1us: SUCCESS (10.397s) [274.101889] [070/131] (746s left) gem_ctx_param (vm) [274.171128] Starting subtest: vm [274.215402] Subtest vm: SUCCESS (0.044s) [274.332875] [071/131] (745s left) kms_psr (fbc-pr-sprite-plane-onoff) [274.426261] Starting subtest: fbc-pr-sprite-plane-onoff [274.430673] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s) [274.498062] [072/131] (745s left) gem_ccs (block-multicopy-compressed) [274.553040] Starting subtest: block-multicopy-compressed [274.557333] Subtest block-multicopy-compressed: SKIP (0.000s) [274.677711] [073/131] (745s left) kms_chamelium_edid (dp-mode-timings) [275.070607] Subtest dp-mode-timings: SKIP (0.000s) [275.901629] [074/131] (744s left) i915_pm_rpm (gem-idle) [278.147863] Starting subtest: gem-idle [284.353775] Subtest gem-idle: SUCCESS (6.209s) [284.658213] [075/131] (735s left) api_intel_bb (bb-with-allocator) [285.901682] Starting subtest: bb-with-allocator [285.907067] Subtest bb-with-allocator: SUCCESS (0.007s) [286.044208] [076/131] (734s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [286.152614] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [286.156961] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [286.237308] [077/131] (734s left) kms_atomic (atomic-plane-damage) [286.332293] Starting subtest: atomic-plane-damage [286.392121] Starting dynamic subtest: pipe-A-eDP-1 [287.008657] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s) [287.011089] Subtest atomic-plane-damage: SUCCESS (0.676s) [287.795043] [078/131] (732s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [287.903132] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [287.905380] Starting dynamic subtest: pipe-A-eDP-1 [303.543031] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.466s) [303.554154] Starting dynamic subtest: pipe-B-eDP-1 [320.466694] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.344s) [320.475651] Starting dynamic subtest: pipe-C-eDP-1 [337.424754] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.296s) [337.434996] Starting dynamic subtest: pipe-D-eDP-1 [354.414208] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.209s) [354.416538] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.320s) [355.677391] [079/131] (723s left) kms_psr (fbc-psr-primary-mmap-gtt) [355.785550] Starting subtest: fbc-psr-primary-mmap-gtt [355.787964] Starting dynamic subtest: eDP-1 [355.792717] Dynamic subtest eDP-1: SKIP (0.000s) [355.797069] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s) [355.858048] [080/131] (722s left) gem_exec_async (forked-writes) [355.929615] Starting subtest: forked-writes [355.932139] Starting dynamic subtest: rcs0 [355.969832] Dynamic subtest rcs0: SUCCESS (0.038s) [355.979920] Starting dynamic subtest: bcs0 [356.000449] Dynamic subtest bcs0: SUCCESS (0.028s) [356.010061] Starting dynamic subtest: vcs0 [356.026842] Dynamic subtest vcs0: SUCCESS (0.024s) [356.037050] Starting dynamic subtest: vcs1 [356.056365] Dynamic subtest vcs1: SUCCESS (0.028s) [356.068152] Starting dynamic subtest: vecs0 [356.086989] Dynamic subtest vecs0: SUCCESS (0.028s) [356.107862] Starting dynamic subtest: ccs0 [356.117244] Dynamic subtest ccs0: SUCCESS (0.029s) [356.120094] Subtest forked-writes: SUCCESS (0.181s) [356.356790] [081/131] (722s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [356.466959] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [356.471487] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [356.580667] [082/131] (722s left) gem_exec_balancer (invalid-balancer) [356.642863] Starting subtest: invalid-balancer [357.388946] Subtest invalid-balancer: SUCCESS (0.720s) [357.688648] [083/131] (721s left) gem_mmap_gtt (basic-short) [357.762371] Subtest basic-short: SKIP (0.000s) [357.829587] [084/131] (721s left) gem_mmap_offset (mmap-boundaries) [357.891840] Starting subtest: mmap-boundaries [357.893923] Starting dynamic subtest: smem0 [358.966655] Dynamic subtest smem0: SUCCESS (1.047s) [358.969354] Subtest mmap-boundaries: SUCCESS (1.047s) [359.151408] [085/131] (719s left) gem_reg_read (bad-register) [359.202598] Starting subtest: bad-register [359.204856] Subtest bad-register: SUCCESS (0.000s) [359.323786] [086/131] (719s left) tools_test (tools_test) [359.374541] Starting subtest: tools_test [359.427852] Subtest tools_test: SUCCESS (0.066s) [359.490116] [087/131] (719s left) kms_cursor_crc (cursor-sliding-256x85) [359.712473] Starting subtest: cursor-sliding-256x85 [359.752254] Subtest cursor-sliding-256x85: SKIP (0.033s) [359.933840] [088/131] (719s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [360.029040] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [360.032641] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [360.136609] [089/131] (719s left) gem_exec_schedule (lateslice) [360.211530] Starting subtest: lateslice [360.213273] Starting dynamic subtest: rcs0 [360.222216] Dynamic subtest rcs0: SUCCESS (0.018s) [360.232259] Starting dynamic subtest: bcs0 [360.239320] Dynamic subtest bcs0: SUCCESS (0.016s) [360.248417] Starting dynamic subtest: vcs0 [360.255000] Dynamic subtest vcs0: SUCCESS (0.015s) [360.263647] Starting dynamic subtest: vcs1 [360.272302] Dynamic subtest vcs1: SUCCESS (0.016s) [360.280698] Starting dynamic subtest: vecs0 [360.288999] Dynamic subtest vecs0: SUCCESS (0.016s) [360.297298] Starting dynamic subtest: ccs0 [360.304184] Dynamic subtest ccs0: SUCCESS (0.014s) [360.306210] Subtest lateslice: SUCCESS (0.099s) [361.927121] [090/131] (717s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [362.034029] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [362.039004] Starting dynamic subtest: A-eDP1 [370.360754] Dynamic subtest A-eDP1: FAIL (7.835s) [370.369694] Starting dynamic subtest: B-eDP1 [382.536649] Dynamic subtest B-eDP1: FAIL (12.062s) [382.547229] Starting dynamic subtest: C-eDP1 [390.964861] Dynamic subtest C-eDP1: SUCCESS (8.897s) [390.975473] Starting dynamic subtest: D-eDP1 [399.894757] Dynamic subtest D-eDP1: SUCCESS (8.927s) [399.901177] Subtest flip-vs-absolute-wf_vblank-interruptible: FAIL (37.735s) [401.112512] [091/131] (678s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [401.232503] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [401.236862] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [401.334699] [092/131] (678s left) kms_psr (psr-suspend) [401.437359] Starting subtest: psr-suspend [401.439651] Starting dynamic subtest: eDP-1 [418.745252] Dynamic subtest eDP-1: SUCCESS (2.844s) [418.747697] Subtest psr-suspend: SUCCESS (2.845s) [419.653634] [093/131] (674s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [419.767929] Starting subtest: yf-tiled-32bpp-rotate-90 [419.773159] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [419.882433] [094/131] (674s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [419.984781] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [425.386823] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (5.249s) [425.503738] [095/131] (668s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [425.609637] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [425.611981] Starting dynamic subtest: pipe-A [425.621724] Dynamic subtest pipe-A: SKIP (0.004s) [425.631248] Starting dynamic subtest: pipe-B [425.640662] Dynamic subtest pipe-B: SKIP (0.015s) [425.649464] Starting dynamic subtest: pipe-C [425.658752] Dynamic subtest pipe-C: SKIP (0.015s) [425.667742] Starting dynamic subtest: pipe-D [425.676713] Dynamic subtest pipe-D: SKIP (0.015s) [425.681266] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.051s) [425.775341] [096/131] (668s left) gem_mmap_gtt (hang) [425.836115] Subtest hang: SKIP (0.000s) [425.895572] [097/131] (668s left) gem_softpin (evict-prime) [425.958261] Starting subtest: evict-prime [425.961149] Starting dynamic subtest: rcs0 [427.165690] Dynamic subtest rcs0: SUCCESS (1.186s) [427.177309] Starting dynamic subtest: bcs0 [428.329050] Dynamic subtest bcs0: SUCCESS (1.144s) [428.342376] Starting dynamic subtest: vcs0 [430.345432] Dynamic subtest vcs0: SUCCESS (1.989s) [430.357889] Starting dynamic subtest: vcs1 [432.329866] Dynamic subtest vcs1: SUCCESS (1.964s) [432.342962] Starting dynamic subtest: vecs0 [434.316381] Dynamic subtest vecs0: SUCCESS (1.970s) [434.330047] Starting dynamic subtest: ccs0 [435.450684] Dynamic subtest ccs0: SUCCESS (1.128s) [435.461024] Starting dynamic subtest: all [437.309237] Dynamic subtest all: SUCCESS (1.846s) [437.312266] Subtest evict-prime: SUCCESS (11.239s) [437.389426] [098/131] (657s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [437.508210] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [437.519469] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s) [437.589737] [099/131] (656s left) gem_exec_whisper (basic-contexts) [437.655899] Starting subtest: basic-contexts [442.863671] Subtest basic-contexts: SUCCESS (5.189s) [443.042852] [100/131] (651s left) core_hotunplug (unbind-rebind) [443.138429] Starting subtest: unbind-rebind [449.218710] Subtest unbind-rebind: SUCCESS (6.070s) [449.254343] [101/131] (645s left) kms_dp_link_training (non-uhbr-mst) [450.297078] Starting subtest: non-uhbr-mst [450.308999] Subtest non-uhbr-mst: SKIP (0.000s) [450.401248] [102/131] (644s left) kms_panel_fitting (legacy) [450.511249] Starting subtest: legacy [450.513997] Starting dynamic subtest: pipe-A-eDP-1 [451.123141] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s) [451.151706] Starting dynamic subtest: pipe-B-eDP-1 [452.813922] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.669s) [452.842378] Starting dynamic subtest: pipe-C-eDP-1 [454.419142] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.582s) [454.445782] Starting dynamic subtest: pipe-D-eDP-1 [456.069399] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.628s) [456.072096] Subtest legacy: SUCCESS (5.553s) [457.293124] [103/131] (637s left) gem_ctx_persistence (saturated-hostile) [457.354247] Starting subtest: saturated-hostile [457.356950] Starting dynamic subtest: rcs0 [458.172005] Dynamic subtest rcs0: SUCCESS (0.817s) [458.185147] Starting dynamic subtest: bcs0 [458.948786] Dynamic subtest bcs0: SUCCESS (0.774s) [458.961935] Starting dynamic subtest: vcs0 [459.767928] Dynamic subtest vcs0: SUCCESS (0.817s) [459.780250] Starting dynamic subtest: vcs1 [460.577638] Dynamic subtest vcs1: SUCCESS (0.808s) [460.591399] Starting dynamic subtest: vecs0 [461.374955] Dynamic subtest vecs0: SUCCESS (0.795s) [461.388252] Starting dynamic subtest: ccs0 [462.217835] Dynamic subtest ccs0: SUCCESS (0.840s) [462.220794] Subtest saturated-hostile: SUCCESS (4.862s) [462.294551] [104/131] (632s left) gem_eio (hibernate) [462.489748] Starting subtest: hibernate [477.160997] Subtest hibernate: SUCCESS (14.664s) [477.286247] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 2428 [max: 8192] direct dependencies: 30004 [max: 524288] indirect dependencies: 266423 all direct dependencies: 651728 dependency chains: 49222 [max: 524288] dependency chain hlocks used: 226677 [max: 2621440] dependency chain hlocks lost: 0 in-hardirq chains: 430 in-softirq chains: 998 in-process chains: 47794 stack-trace entries: 318146 [max: 524288] number of stack traces: 14383 number of stack hash chains: 9542 combined max dependencies: 3399176171 hardirq-safe locks: 141 hardirq-unsafe locks: 1394 softirq-safe locks: 278 softirq-unsafe locks: 1286 irq-safe locks: 305 irq-unsafe locks: 1394 hardirq-read-safe locks: 5 hardirq-read-unsafe locks: 467 softirq-read-safe locks: 10 softirq-read-unsafe locks: 462 irq-read-safe locks: 10 irq-read-unsafe locks: 467 uncategorized locks: 399 unused locks: 1 max locking depth: 17 max bfs queue depth: 443 max lock class index: 2427 debug_locks: 0 zapped classes: 18 zapped lock chains: 2421 large chain blocks: 1 [477.297888] Closing watchdogs results: parsing output: 0/ for test: kms_ccs results: parsing output: 1/ for test: kms_addfb_basic results: parsing output: 2/ for test: kms_ccs results: parsing output: 3/ for test: kms_psr results: parsing output: 4/ for test: kms_flip_scaled_crc results: parsing output: 5/ for test: drm_fdinfo results: parsing output: 6/ for test: gem_ctx_exec results: parsing output: 7/ for test: gem_render_copy results: parsing output: 8/ for test: sysfs_heartbeat_interval results: parsing output: 9/ for test: kms_psr2_sf results: parsing output: 10/ for test: kms_flip_scaled_crc results: parsing output: 11/ for test: kms_cursor_crc results: parsing output: 12/ for test: kms_plane results: parsing output: 13/ for test: kms_cursor_legacy results: parsing output: 14/ for test: kms_big_fb results: parsing output: 15/ for test: gem_exec_schedule results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: gem_linear_blits results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_psr results: parsing output: 20/ for test: kms_chamelium_hpd results: parsing output: 21/ for test: kms_dirtyfb results: parsing output: 22/ for test: syncobj_wait results: parsing output: 23/ for test: prime_vgem results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_prop_blob results: parsing output: 26/ for test: drm_fdinfo results: parsing output: 27/ for test: gem_gpgpu_fill results: parsing output: 28/ for test: kms_pm_dc results: parsing output: 29/ for test: gem_pxp results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: gem_render_copy results: parsing output: 32/ for test: core_setmaster_vs_auth results: parsing output: 33/ for test: syncobj_wait results: parsing output: 34/ for test: vgem_basic results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: syncobj_timeline results: parsing output: 38/ for test: gem_exec_reloc results: parsing output: 39/ for test: gem_ctx_param results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: gem_userptr_blits results: parsing output: 43/ for test: api_intel_allocator results: parsing output: 44/ for test: kms_ccs results: parsing output: 45/ for test: syncobj_timeline results: parsing output: 46/ for test: perf results: parsing output: 47/ for test: gem_create results: parsing output: 48/ for test: gem_exec_reloc results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_userptr_blits results: parsing output: 51/ for test: gem_exec_big results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_getfb results: parsing output: 54/ for test: kms_vblank results: parsing output: 55/ for test: gem_exec_reloc results: parsing output: 56/ for test: syncobj_timeline results: parsing output: 57/ for test: gem_exec_schedule results: parsing output: 58/ for test: kms_lease results: parsing output: 59/ for test: gem_exec_gttfill results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: gem_exec_fence results: parsing output: 62/ for test: kms_psr2_sf results: parsing output: 63/ for test: i915_pciid results: parsing output: 64/ for test: gem_mmap_gtt results: parsing output: 65/ for test: kms_fbcon_fbt results: parsing output: 66/ for test: kms_joiner results: parsing output: 67/ for test: kms_busy results: parsing output: 68/ for test: gem_eio results: parsing output: 69/ for test: gem_ctx_param results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: gem_ccs results: parsing output: 72/ for test: kms_chamelium_edid results: parsing output: 73/ for test: i915_pm_rpm results: parsing output: 74/ for test: api_intel_bb results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_atomic results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: kms_psr results: parsing output: 79/ for test: gem_exec_async results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: gem_exec_balancer results: parsing output: 82/ for test: gem_mmap_gtt results: parsing output: 83/ for test: gem_mmap_offset results: parsing output: 84/ for test: gem_reg_read results: parsing output: 85/ for test: tools_test results: parsing output: 86/ for test: kms_cursor_crc results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: gem_exec_schedule results: parsing output: 89/ for test: kms_flip results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_psr results: parsing output: 92/ for test: kms_big_fb results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_plane_scaling results: parsing output: 95/ for test: gem_mmap_gtt results: parsing output: 96/ for test: gem_softpin results: parsing output: 97/ for test: kms_flip results: parsing output: 98/ for test: gem_exec_whisper results: parsing output: 99/ for test: core_hotunplug results: parsing output: 100/ for test: kms_dp_link_training results: parsing output: 101/ for test: kms_panel_fitting results: parsing output: 102/ for test: gem_ctx_persistence results: parsing output: 103/ for test: gem_eio results: parsing output: 104/ for test: kms_sequence results: no output, setting notrun results: parsing output: 105/ for test: kms_writeback results: no output, setting notrun results: parsing output: 106/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 107/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 108/ for test: gem_watchdog results: no output, setting notrun results: parsing output: 109/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 110/ for test: gem_ctx_param results: no output, setting notrun results: parsing output: 111/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 112/ for test: kms_color results: no output, setting notrun results: parsing output: 113/ for test: gen9_exec_parse results: no output, setting notrun results: parsing output: 114/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 115/ for test: gem_exec_flush results: no output, setting notrun results: parsing output: 116/ for test: gem_ctx_param results: no output, setting notrun results: parsing output: 117/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 118/ for test: gem_caching results: no output, setting notrun results: parsing output: 119/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 120/ for test: kms_cursor_crc results: no output, setting notrun results: parsing output: 121/ for test: prime_busy results: no output, setting notrun results: parsing output: 122/ for test: gem_render_copy results: no output, setting notrun results: parsing output: 123/ for test: kms_pm_rpm results: no output, setting notrun results: parsing output: 124/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 125/ for test: kms_pipe_crc_basic results: no output, setting notrun results: parsing output: 126/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 127/ for test: gem_eio results: no output, setting notrun results: parsing output: 128/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 129/ for test: gem_mmap_wc results: no output, setting notrun results: parsing output: 130/ for test: kms_flip_scaled_crc results: no output, setting notrun Done.