[57.027159] Initializing watchdogs [57.027211] /dev/watchdog0 [57.042744] [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.047229] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.049492] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.052995] [001/156] (960s left) gem_mmap_wc (write-prefaulted) [57.124219] Subtest write-prefaulted: SKIP (0.000s) [57.178404] [002/156] (960s left) kms_hdr (static-toggle-dpms) [57.288618] Starting subtest: static-toggle-dpms [57.290942] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [57.295110] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [57.302775] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [57.306804] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [57.310816] Subtest static-toggle-dpms: SKIP (0.002s) [57.373080] [003/156] (960s left) gem_exec_schedule (u-submit-early-slice) [57.446827] Starting subtest: u-submit-early-slice [57.448712] Starting dynamic subtest: rcs0 [57.492964] Dynamic subtest rcs0: SUCCESS (0.050s) [57.505531] Starting dynamic subtest: bcs0 [57.532998] Dynamic subtest bcs0: SUCCESS (0.040s) [57.543969] Starting dynamic subtest: vcs0 [57.570597] Dynamic subtest vcs0: SUCCESS (0.037s) [57.579333] Starting dynamic subtest: vcs1 [57.606328] Dynamic subtest vcs1: SUCCESS (0.036s) [57.615393] Starting dynamic subtest: vecs0 [57.642440] Dynamic subtest vecs0: SUCCESS (0.036s) [57.651479] Starting dynamic subtest: ccs0 [57.676628] Dynamic subtest ccs0: SUCCESS (0.034s) [57.678994] Subtest u-submit-early-slice: SUCCESS (0.234s) [59.385253] [004/156] (958s left) gem_exec_reloc (basic-wc-cpu-active) [59.451239] Subtest basic-wc-cpu-active: SKIP (0.000s) [59.522679] [005/156] (958s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [59.582282] Starting subtest: yf-tiled-ccs-to-y-tiled [59.586711] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [59.763825] [006/156] (957s left) gem_exec_parallel (fds) [59.836437] Starting subtest: fds [59.839174] Starting dynamic subtest: rcs0 [63.108579] Dynamic subtest rcs0: SUCCESS (3.271s) [63.118196] Starting dynamic subtest: bcs0 [66.368757] Dynamic subtest bcs0: SUCCESS (3.258s) [66.379282] Starting dynamic subtest: vcs0 [70.528710] Dynamic subtest vcs0: SUCCESS (4.159s) [70.536792] Starting dynamic subtest: vcs1 [74.673564] Dynamic subtest vcs1: SUCCESS (4.143s) [74.683686] Starting dynamic subtest: vecs0 [78.559834] Dynamic subtest vecs0: SUCCESS (3.886s) [78.569026] Starting dynamic subtest: ccs0 [81.992260] Dynamic subtest ccs0: SUCCESS (3.432s) [81.995397] Subtest fds: SUCCESS (22.156s) [82.199213] [007/156] (935s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-render) [82.311701] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-render [82.315796] Subtest hdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [82.421886] [008/156] (935s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [82.516444] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [89.863997] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.355s) [89.986778] [009/156] (927s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc) [90.085241] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc [90.089432] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [90.193723] [010/156] (927s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [90.293957] Starting subtest: yf-tiled-64bpp-rotate-0 [90.298569] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [90.386109] [011/156] (927s left) gen9_exec_parse (batch-zero-length) [90.438365] Subtest batch-zero-length: SKIP (0.000s) [90.505926] [012/156] (927s left) i915_pciid [90.646703] [013/156] (927s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [90.740910] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [91.874470] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.134s) [91.998737] [014/156] (926s left) gem_exec_fence (syncobj-timeline-unused-fence) [92.590954] Starting subtest: syncobj-timeline-unused-fence [92.596741] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s) [94.372476] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true [94.375692] [015/156] (923s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [94.458082] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [94.460302] Starting dynamic subtest: pipe-A-eDP-1 [94.483444] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s) [94.492573] Starting dynamic subtest: pipe-B-eDP-1 [94.512171] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s) [94.520697] Starting dynamic subtest: pipe-C-eDP-1 [94.541096] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s) [94.550102] Starting dynamic subtest: pipe-D-eDP-1 [94.569688] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s) [94.571951] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.088s) [96.876421] [016/156] (921s left) gem_userptr_blits (huge-split) [96.942529] Starting subtest: huge-split [96.950325] Subtest huge-split: SUCCESS (0.008s) [97.068220] [017/156] (921s left) kms_big_fb (y-tiled-32bpp-rotate-270) [97.166322] Starting subtest: y-tiled-32bpp-rotate-270 [97.170664] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [97.246697] [018/156] (920s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render) [97.349557] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render [97.353733] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [97.446589] [019/156] (920s left) gem_ctx_param (invalid-size-get) [97.498416] Starting subtest: invalid-size-get [97.500884] Subtest invalid-size-get: SUCCESS (0.001s) [97.617672] [020/156] (920s left) kms_rmfb (rmfb-ioctl) [97.707132] Starting subtest: rmfb-ioctl [97.709376] Starting dynamic subtest: pipe-A-eDP-1 [97.811166] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [97.821203] Starting dynamic subtest: pipe-B-eDP-1 [99.047418] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.235s) [99.057678] Starting dynamic subtest: pipe-C-eDP-1 [100.266294] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.218s) [100.276763] Starting dynamic subtest: pipe-D-eDP-1 [101.404828] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s) [101.407244] Subtest rmfb-ioctl: SUCCESS (3.700s) [102.617428] [021/156] (915s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff) [102.719959] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff [102.724597] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [102.799879] [022/156] (915s left) kms_cursor_crc (cursor-sliding-512x512) [103.070854] Starting subtest: cursor-sliding-512x512 [103.075387] Subtest cursor-sliding-512x512: SKIP (0.001s) [103.235168] [023/156] (915s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render) [103.331161] Starting subtest: fbcpsr-rgb565-draw-render [110.429527] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.104s) [110.563905] [024/156] (907s left) i915_suspend (basic-s3-without-i915) [110.602872] Starting subtest: basic-s3-without-i915 [113.903664] Subtest basic-s3-without-i915: SKIP (3.296s) [115.489783] [025/156] (903s left) kms_frontbuffer_tracking (fbc-1p-rte) [115.595399] Starting subtest: fbc-1p-rte [121.053478] Subtest fbc-1p-rte: SUCCESS (5.464s) [122.211932] [026/156] (896s left) kms_getfb (getfb-handle-valid) [122.308300] Starting subtest: getfb-handle-valid [122.310619] Subtest getfb-handle-valid: SUCCESS (0.000s) [122.436359] [027/156] (896s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [122.535853] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [122.540170] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [122.643076] [028/156] (896s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt) [122.735766] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt [122.740096] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [122.828010] [029/156] (895s left) kms_lease (invalid-create-leases) [122.927097] Starting subtest: invalid-create-leases [122.931763] Subtest invalid-create-leases: SUCCESS (0.006s) [123.052631] [030/156] (895s left) gem_ccs (suspend-resume) [123.104678] Starting subtest: suspend-resume [123.108501] Subtest suspend-resume: SKIP (0.000s) [123.210511] [031/156] (895s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-plflip-blt) [123.304767] Starting subtest: psrhdr-1p-primscrn-shrfb-plflip-blt [123.308424] Subtest psrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [123.402270] [032/156] (895s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats) [123.788043] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s) [124.612457] [033/156] (894s left) kms_cursor_legacy (torture-move) [124.734653] Starting subtest: torture-move [124.736985] Starting dynamic subtest: pipe-A [130.357570] Dynamic subtest pipe-A: SUCCESS (5.619s) [130.369876] Starting dynamic subtest: pipe-B [136.713095] Dynamic subtest pipe-B: SUCCESS (6.355s) [136.721901] Starting dynamic subtest: pipe-C [143.740373] Dynamic subtest pipe-C: SUCCESS (7.025s) [143.749033] Starting dynamic subtest: pipe-D [151.292226] Dynamic subtest pipe-D: SUCCESS (7.548s) [151.305677] Starting dynamic subtest: all-pipes [156.953401] Dynamic subtest all-pipes: SUCCESS (5.662s) [156.955665] Subtest torture-move: SUCCESS (32.219s) [157.114394] [034/156] (861s left) kms_plane_multiple (tiling-x) [157.215990] Starting subtest: tiling-x [157.218209] Starting dynamic subtest: pipe-A-eDP-1 [161.157461] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.940s) [161.168623] Starting dynamic subtest: pipe-B-eDP-1 [165.607046] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.447s) [165.618446] Starting dynamic subtest: pipe-C-eDP-1 [170.036392] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.429s) [170.045114] Starting dynamic subtest: pipe-D-eDP-1 [174.367496] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.328s) [174.369784] Subtest tiling-x: SUCCESS (17.151s) [175.188862] [035/156] (843s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [175.282387] Starting subtest: planes-downscale-factor-0-5-unity-scaling [175.284740] Starting dynamic subtest: pipe-A [175.305825] Dynamic subtest pipe-A: SKIP (0.019s) [175.314771] Starting dynamic subtest: pipe-B [175.335435] Dynamic subtest pipe-B: SKIP (0.030s) [175.344063] Starting dynamic subtest: pipe-C [175.367380] Dynamic subtest pipe-C: SKIP (0.031s) [175.375731] Starting dynamic subtest: pipe-D [175.396971] Dynamic subtest pipe-D: SKIP (0.031s) [175.401046] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.113s) [175.492296] [036/156] (843s left) kms_cdclk (mode-transition) [175.601149] Starting subtest: mode-transition [175.603359] Starting dynamic subtest: pipe-A-eDP-1 [175.891327] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s) [175.899524] Starting dynamic subtest: pipe-B-eDP-1 [175.904067] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [175.912502] Starting dynamic subtest: pipe-C-eDP-1 [175.917129] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [175.925268] Starting dynamic subtest: pipe-D-eDP-1 [175.929571] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [175.933863] Subtest mode-transition: SKIP (0.295s) [176.719691] [037/156] (842s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [176.815162] Starting subtest: crc-primary-suspend-y-tiled-ccs [176.817639] Starting dynamic subtest: pipe-A-eDP-1 [176.827218] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [176.837212] Starting dynamic subtest: pipe-B-eDP-1 [176.846489] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [176.855048] Starting dynamic subtest: pipe-C-eDP-1 [176.864271] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [176.872239] Starting dynamic subtest: pipe-D-eDP-1 [176.881069] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [176.885415] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s) [179.096694] [038/156] (839s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier) [179.210105] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier [179.214500] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s) [179.282522] [039/156] (839s left) gem_exec_fence (parallel) [179.448425] Starting subtest: parallel [179.450753] Starting dynamic subtest: rcs0 [181.598044] Dynamic subtest rcs0: SUCCESS (2.150s) [181.606168] Starting dynamic subtest: bcs0 [183.746952] Dynamic subtest bcs0: SUCCESS (2.148s) [183.755767] Starting dynamic subtest: vcs0 [185.900493] Dynamic subtest vcs0: SUCCESS (2.153s) [185.910144] Starting dynamic subtest: vcs1 [188.054499] Dynamic subtest vcs1: SUCCESS (2.153s) [188.064794] Starting dynamic subtest: vecs0 [190.208095] Dynamic subtest vecs0: SUCCESS (2.151s) [190.217324] Starting dynamic subtest: ccs0 [192.359026] Dynamic subtest ccs0: SUCCESS (2.150s) [192.361059] Subtest parallel: SUCCESS (12.912s) [194.423431] [040/156] (824s left) kms_flip (modeset-vs-vblank-race) [194.525276] Starting subtest: modeset-vs-vblank-race [194.527584] Starting dynamic subtest: A-eDP1 [199.228562] Dynamic subtest A-eDP1: SUCCESS (4.702s) [199.240994] Starting dynamic subtest: B-eDP1 [203.971125] Dynamic subtest B-eDP1: SUCCESS (4.740s) [203.984935] Starting dynamic subtest: C-eDP1 [208.658291] Dynamic subtest C-eDP1: SUCCESS (4.684s) [208.667906] Starting dynamic subtest: D-eDP1 [213.329515] Dynamic subtest D-eDP1: SUCCESS (4.670s) [213.334726] Subtest modeset-vs-vblank-race: SUCCESS (18.810s) [214.514506] [041/156] (804s left) gem_lmem_swapping (parallel-multi) [214.559193] Subtest parallel-multi: SKIP (0.000s) [214.606532] [042/156] (804s left) syncobj_timeline (single-wait-all-signaled) [214.659334] Starting subtest: single-wait-all-signaled [214.661564] Subtest single-wait-all-signaled: SUCCESS (0.001s) [214.753829] [043/156] (804s left) kms_joiner (basic-force-big-joiner) [214.845159] Starting subtest: basic-force-big-joiner [214.849404] Subtest basic-force-big-joiner: SKIP (0.000s) [214.914334] [044/156] (804s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [215.016745] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [215.020948] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [215.164439] [045/156] (804s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc) [215.258738] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc [221.854727] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.600s) [221.969726] [046/156] (797s left) api_intel_allocator (reserve-simple) [222.020641] Starting subtest: reserve-simple [222.023044] Subtest reserve-simple: SUCCESS (0.003s) [222.135504] [047/156] (797s left) kms_flip (2x-absolute-wf_vblank) [222.227071] Starting subtest: 2x-absolute-wf_vblank [222.239162] Subtest 2x-absolute-wf_vblank: SKIP (0.011s) [222.317239] [048/156] (797s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [222.431633] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [233.612232] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.181s) [234.515217] [049/156] (785s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [234.616741] Starting subtest: fbc-1p-pri-indfb-multidraw [247.699887] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.089s) [249.125589] [050/156] (770s left) kms_scaling_modes (scaling-mode-none) [249.217978] Starting subtest: scaling-mode-none [249.219851] Starting dynamic subtest: pipe-A-eDP-1 [249.316085] Dynamic subtest pipe-A-eDP-1: SKIP (0.097s) [249.326890] Starting dynamic subtest: pipe-B-eDP-1 [249.354293] Dynamic subtest pipe-B-eDP-1: SKIP (0.036s) [249.363738] Starting dynamic subtest: pipe-C-eDP-1 [249.386656] Dynamic subtest pipe-C-eDP-1: SKIP (0.031s) [249.395699] Starting dynamic subtest: pipe-D-eDP-1 [249.420677] Dynamic subtest pipe-D-eDP-1: SKIP (0.033s) [249.425122] Subtest scaling-mode-none: SKIP (0.203s) [249.540288] [051/156] (770s left) prime_self_import (basic-llseek-bad) [249.575905] Starting subtest: basic-llseek-bad [249.599467] Subtest basic-llseek-bad: SUCCESS (0.023s) [249.717430] [052/156] (769s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc) [249.821109] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc [249.825524] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [249.919852] [053/156] (769s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt) [250.019815] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt [250.024200] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [250.141516] [054/156] (769s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-plflip-blt) [250.241589] Starting subtest: hdr-2p-scndscrn-shrfb-plflip-blt [250.245188] Subtest hdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [250.331331] [055/156] (769s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [250.424837] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [250.428261] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [250.521772] [056/156] (769s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [250.625069] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [251.604615] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.979s) [251.737812] [057/156] (768s left) kms_content_protection (atomic-dpms-hdcp14) [251.881703] Starting subtest: atomic-dpms-hdcp14 [251.885312] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [251.999521] [058/156] (767s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [252.093646] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [252.095636] Starting dynamic subtest: pipe-A-eDP-1 [252.113118] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [252.123030] Starting dynamic subtest: pipe-B-eDP-1 [252.139483] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [252.147886] Starting dynamic subtest: pipe-C-eDP-1 [252.163896] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [252.173541] Starting dynamic subtest: pipe-D-eDP-1 [252.189524] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [252.191473] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s) [254.376318] [059/156] (765s left) kms_pm_rpm (fences-dpms) [256.507609] Starting subtest: fences-dpms [256.512822] Subtest fences-dpms: SKIP (0.000s) [256.901891] [060/156] (763s left) perf_pmu (init-sema) [256.941786] Starting subtest: init-sema [256.943938] Starting dynamic subtest: rcs0 [256.946152] Dynamic subtest rcs0: SUCCESS (0.003s) [256.955112] Starting dynamic subtest: bcs0 [256.957289] Dynamic subtest bcs0: SUCCESS (0.000s) [256.965991] Starting dynamic subtest: vcs0 [256.968164] Dynamic subtest vcs0: SUCCESS (0.001s) [256.977228] Starting dynamic subtest: vcs1 [256.979287] Dynamic subtest vcs1: SUCCESS (0.000s) [256.987815] Starting dynamic subtest: vecs0 [256.989697] Dynamic subtest vecs0: SUCCESS (0.000s) [256.998241] Starting dynamic subtest: ccs0 [257.000377] Dynamic subtest ccs0: SUCCESS (0.000s) [257.002508] Subtest init-sema: SUCCESS (0.010s) [257.042505] [061/156] (763s left) kms_busy (extended-modeset-hang-newfb) [257.147393] Starting subtest: extended-modeset-hang-newfb [257.149337] Starting dynamic subtest: pipe-A [291.259350] Dynamic subtest pipe-A: SUCCESS (34.112s) [291.270947] Starting dynamic subtest: pipe-D [314.288852] Dynamic subtest pipe-D: SUCCESS (23.027s) [314.291558] Subtest extended-modeset-hang-newfb: SUCCESS (57.144s) [315.176958] [062/156] (704s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [315.267987] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [318.833464] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.571s) [319.983724] [063/156] (700s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [320.092045] Starting subtest: primary-x-tiled-reflect-x-0 [326.994445] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.906s) [328.167915] [064/156] (692s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [328.279214] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc [328.283597] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [328.382592] [065/156] (691s left) kms_flip (bo-too-big-interruptible) [328.469934] Starting subtest: bo-too-big-interruptible [328.472134] Starting dynamic subtest: A-eDP1 [329.798315] Dynamic subtest A-eDP1: SUCCESS (1.327s) [329.807796] Starting dynamic subtest: B-eDP1 [331.143120] Dynamic subtest B-eDP1: SUCCESS (1.343s) [331.153142] Starting dynamic subtest: C-eDP1 [332.468755] Dynamic subtest C-eDP1: SUCCESS (1.325s) [332.478242] Starting dynamic subtest: D-eDP1 [333.793404] Dynamic subtest D-eDP1: SUCCESS (1.323s) [333.795805] Subtest bo-too-big-interruptible: SUCCESS (5.326s) [335.015658] [066/156] (685s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [335.144025] Starting subtest: basic-flip-after-cursor-varying-size [336.061731] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.923s) [336.926763] [067/156] (683s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [336.975936] Starting subtest: multi-wait-for-submit-available-submitted-signaled [336.978264] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [337.062822] [068/156] (683s left) kms_big_fb (linear-8bpp-rotate-180) [337.155982] Starting subtest: linear-8bpp-rotate-180 [338.378755] Subtest linear-8bpp-rotate-180: SUCCESS (1.224s) [338.491766] [069/156] (681s left) kms_addfb_basic (invalid-set-prop-any) [338.541442] Starting subtest: invalid-set-prop-any [338.543405] Subtest invalid-set-prop-any: SUCCESS (0.000s) [338.682223] [070/156] (681s left) kms_flip (2x-flip-vs-panning-interruptible) [338.763874] Starting subtest: 2x-flip-vs-panning-interruptible [338.775417] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s) [338.861921] [071/156] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [338.956647] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [338.960129] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [339.046965] [072/156] (681s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-wc) [339.148466] Starting subtest: psrhdr-rgb565-draw-mmap-wc [339.151958] Subtest psrhdr-rgb565-draw-mmap-wc: SKIP (0.000s) [339.260866] [073/156] (681s left) gem_eio (create) [339.495983] Starting subtest: create [339.828862] Subtest create: SUCCESS (0.332s) [339.974406] [074/156] (680s left) gem_ctx_persistence (engines-mixed) [340.041811] Starting subtest: engines-mixed [340.043771] Starting dynamic subtest: rcs0 [340.104349] Dynamic subtest rcs0: SUCCESS (0.065s) [340.114988] Starting dynamic subtest: bcs0 [340.146853] Dynamic subtest bcs0: SUCCESS (0.042s) [340.160910] Starting dynamic subtest: vcs0 [340.208380] Dynamic subtest vcs0: SUCCESS (0.059s) [340.221227] Starting dynamic subtest: vcs1 [340.272563] Dynamic subtest vcs1: SUCCESS (0.062s) [340.285165] Starting dynamic subtest: vecs0 [340.331476] Dynamic subtest vecs0: SUCCESS (0.057s) [340.344411] Starting dynamic subtest: ccs0 [340.406789] Dynamic subtest ccs0: SUCCESS (0.073s) [340.409384] Subtest engines-mixed: SUCCESS (0.368s) [340.488485] [075/156] (680s left) kms_addfb_basic (too-high) [340.575333] Starting subtest: too-high [340.577289] Subtest too-high: SUCCESS (0.001s) [340.670408] [076/156] (680s left) i915_query (query-topology-unsupported) [340.726830] Starting subtest: query-topology-unsupported [340.730487] Subtest query-topology-unsupported: SKIP (0.000s) [340.825191] [077/156] (679s left) gem_mmap_offset (clear) [340.871045] Starting subtest: clear [340.873668] Starting dynamic subtest: smem0 [365.990202] Dynamic subtest smem0: SUCCESS (25.113s) [365.992223] Subtest clear: SUCCESS (25.115s) [366.124268] [078/156] (654s left) i915_drm_fdinfo (busy-check-all) [366.218981] Starting subtest: busy-check-all [366.221362] Starting dynamic subtest: rcs0 [366.228864] Dynamic subtest rcs0: SKIP (0.007s) [366.241389] Starting dynamic subtest: bcs0 [366.245395] Dynamic subtest bcs0: SKIP (0.000s) [366.255041] Starting dynamic subtest: vcs0 [366.259494] Dynamic subtest vcs0: SKIP (0.000s) [366.269787] Starting dynamic subtest: vcs1 [366.273858] Dynamic subtest vcs1: SKIP (0.000s) [366.282804] Starting dynamic subtest: vecs0 [366.287077] Dynamic subtest vecs0: SKIP (0.000s) [366.296484] Starting dynamic subtest: ccs0 [366.300823] Dynamic subtest ccs0: SKIP (0.000s) [366.305183] Subtest busy-check-all: SKIP (0.012s) [366.344260] [079/156] (654s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [366.496509] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [366.501123] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [366.598918] [080/156] (654s left) kms_frontbuffer_tracking (fbchdr-1p-rte) [366.695536] Starting subtest: fbchdr-1p-rte [366.699618] Subtest fbchdr-1p-rte: SKIP (0.000s) [366.794660] [081/156] (654s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-render) [366.899233] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-render [366.902860] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [367.001559] [082/156] (653s left) sysfs_timeslice_duration (duration) [367.060156] Starting subtest: duration [367.062068] Starting dynamic subtest: vecs0 [380.221296] Dynamic subtest vecs0: SUCCESS (13.157s) [380.232909] Starting dynamic subtest: ccs0 [393.386948] Dynamic subtest ccs0: SUCCESS (13.147s) [393.398763] Starting dynamic subtest: vcs0 [407.230621] Dynamic subtest vcs0: SUCCESS (13.859s) [407.243496] Starting dynamic subtest: bcs0 [420.383428] Dynamic subtest bcs0: SUCCESS (13.144s) [420.396356] Starting dynamic subtest: rcs0 [433.542373] Dynamic subtest rcs0: SUCCESS (13.146s) [433.553141] Starting dynamic subtest: vcs1 [448.316376] Dynamic subtest vcs1: SUCCESS (14.787s) [448.319112] Subtest duration: SUCCESS (81.255s) [448.418469] [083/156] (572s left) gem_exec_store (dword) [448.485993] Starting subtest: dword [448.488510] Starting dynamic subtest: rcs0 [448.560059] Dynamic subtest rcs0: SUCCESS (0.074s) [448.572959] Starting dynamic subtest: bcs0 [448.605795] Dynamic subtest bcs0: SUCCESS (0.044s) [448.618808] Starting dynamic subtest: vcs0 [448.650613] Dynamic subtest vcs0: SUCCESS (0.042s) [448.663341] Starting dynamic subtest: vcs1 [448.690998] Dynamic subtest vcs1: SUCCESS (0.039s) [448.703726] Starting dynamic subtest: vecs0 [448.734250] Dynamic subtest vecs0: SUCCESS (0.041s) [448.747635] Starting dynamic subtest: ccs0 [448.779965] Dynamic subtest ccs0: SUCCESS (0.043s) [448.782706] Subtest dword: SUCCESS (0.295s) [448.979314] [084/156] (572s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [449.087769] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [449.092222] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [449.185110] [085/156] (571s left) kms_plane_alpha_blend (alpha-basic) [449.278062] Starting subtest: alpha-basic [449.571990] Starting dynamic subtest: pipe-A-eDP-1 [451.495457] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.921s) [451.525696] Starting dynamic subtest: pipe-D-eDP-1 [454.208770] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.692s) [454.211250] Subtest alpha-basic: SUCCESS (4.931s) [455.084718] [086/156] (566s left) kms_cursor_crc (cursor-rapid-movement-32x32) [455.233764] Starting subtest: cursor-rapid-movement-32x32 [455.283272] Subtest cursor-rapid-movement-32x32: SKIP (0.044s) [455.595252] [087/156] (565s left) syncobj_timeline (host-signal-points) [455.660410] Starting subtest: host-signal-points [455.665907] Subtest host-signal-points: SUCCESS (0.005s) [455.761494] [088/156] (565s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [455.846645] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [455.937842] [089/156] (565s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [456.028203] Starting subtest: ccs-on-another-bo-y-tiled-ccs [456.030235] Starting dynamic subtest: pipe-A-eDP-1 [456.049655] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [456.061997] Starting dynamic subtest: pipe-B-eDP-1 [456.079828] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [456.089574] Starting dynamic subtest: pipe-C-eDP-1 [456.107610] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [456.116468] Starting dynamic subtest: pipe-D-eDP-1 [456.134826] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [456.138157] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s) [458.342201] [090/156] (562s left) gem_exec_schedule (preempt-other) [458.421065] Starting subtest: preempt-other [458.423279] Starting dynamic subtest: rcs0 [458.486406] Dynamic subtest rcs0: SUCCESS (0.071s) [458.502547] Starting dynamic subtest: bcs0 [458.553866] Dynamic subtest bcs0: SUCCESS (0.066s) [458.567291] Starting dynamic subtest: vcs0 [458.618411] Dynamic subtest vcs0: SUCCESS (0.064s) [458.633450] Starting dynamic subtest: vcs1 [458.684892] Dynamic subtest vcs1: SUCCESS (0.066s) [458.699597] Starting dynamic subtest: vecs0 [458.751145] Dynamic subtest vecs0: SUCCESS (0.066s) [458.766378] Starting dynamic subtest: ccs0 [458.819596] Dynamic subtest ccs0: SUCCESS (0.068s) [458.821946] Subtest preempt-other: SUCCESS (0.405s) [460.430456] [091/156] (560s left) gem_ctx_persistence (legacy-engines-queued) [460.496511] Starting subtest: legacy-engines-queued [460.498519] Starting dynamic subtest: render [460.568500] Dynamic subtest render: SUCCESS (0.074s) [460.584250] Starting dynamic subtest: bsd1 [462.271572] Dynamic subtest bsd1: SUCCESS (1.698s) [462.283094] Starting dynamic subtest: bsd2 [464.371144] Dynamic subtest bsd2: SUCCESS (2.042s) [464.383900] Starting dynamic subtest: blt [464.385999] Dynamic subtest blt: SUCCESS (0.060s) [464.395661] Starting dynamic subtest: vebox [466.300705] Dynamic subtest vebox: SUCCESS (1.917s) [466.303757] Subtest legacy-engines-queued: SUCCESS (5.807s) [466.383505] [092/156] (555s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [466.445515] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [466.546245] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s) [466.627167] [093/156] (554s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [466.722601] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [466.724771] Starting dynamic subtest: pipe-A-default-mode [467.887308] Dynamic subtest pipe-A-default-mode: SKIP (1.161s) [467.891552] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.163s) [468.026205] [094/156] (553s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [468.132964] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc [468.137305] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [468.224502] [095/156] (553s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [468.276154] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [468.333395] [096/156] (553s left) dmabuf_sync_file (import-multiple-read-only) [468.374858] Starting subtest: import-multiple-read-only [468.377177] Subtest import-multiple-read-only: SUCCESS (0.003s) [468.433241] [097/156] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [468.522998] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [468.527287] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [468.611921] [098/156] (553s left) i915_pm_rps (min-max-config-loaded) [468.669756] Starting subtest: min-max-config-loaded [468.674319] Subtest min-max-config-loaded: SKIP (0.001s) [468.772768] [099/156] (552s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-render) [468.868729] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-render [468.872205] Subtest fbchdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [468.966891] [100/156] (552s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [469.024495] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [469.131325] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s) [469.209329] [101/156] (552s left) gem_busy (semaphore) [469.392345] Subtest semaphore: SKIP (0.000s) [469.613298] [102/156] (552s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs) [469.692401] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs [469.696643] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s) [469.875906] [103/156] (551s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [469.979565] Starting subtest: psr2-primary-plane-update-sf-dmg-area [469.982031] Starting dynamic subtest: pipe-A-eDP-1 [475.815311] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.841s) [475.826865] Starting dynamic subtest: pipe-B-eDP-1 [482.485092] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.668s) [482.487537] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.512s) [483.376046] [104/156] (538s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [483.471612] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [483.475693] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [483.570745] [105/156] (538s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [483.672773] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area [483.674967] Starting dynamic subtest: pipe-A-eDP-1 [483.757500] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s) [483.768506] Starting dynamic subtest: pipe-B-eDP-1 [484.945456] Dynamic subtest pipe-B-eDP-1: SKIP (1.185s) [484.949803] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.276s) [486.142078] [106/156] (535s left) gem_workarounds (basic-read-fd) [486.219892] Starting subtest: basic-read-fd [486.237554] Subtest basic-read-fd: SUCCESS (0.021s) [486.366953] [107/156] (535s left) kms_prop_blob (blob-multiple) [486.433611] Starting subtest: blob-multiple [486.436025] Subtest blob-multiple: SUCCESS (0.002s) [486.544946] [108/156] (535s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [486.649841] Starting subtest: fbc-psr2-sprite-mmap-cpu [486.652325] Starting dynamic subtest: eDP-1 [486.656941] Dynamic subtest eDP-1: SKIP (0.000s) [486.661618] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [486.723692] [109/156] (535s left) syncobj_eventfd (invalid-bad-pad) [486.773500] Starting subtest: invalid-bad-pad [486.775438] Subtest invalid-bad-pad: SUCCESS (0.000s) [486.856394] [110/156] (535s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-wc) [486.954871] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-wc [486.959435] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [487.063924] [111/156] (535s left) kms_pm_backlight (fade-with-dpms) [487.158405] Starting subtest: fade-with-dpms [489.310627] Starting dynamic subtest: eDP-1 [492.310544] Dynamic subtest eDP-1: SUCCESS (3.002s) [492.313045] Subtest fade-with-dpms: SUCCESS (5.153s) [493.195288] [112/156] (529s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [493.292958] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [493.297076] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [493.394069] [113/156] (528s left) gem_exec_reloc (basic-wc-cpu-noreloc) [493.459611] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [493.535424] [114/156] (528s left) gem_softpin (reverse) [493.601250] Starting subtest: reverse [493.607896] Subtest reverse: SUCCESS (0.007s) [493.725825] [115/156] (528s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt) [493.826455] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt [493.830583] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [493.921102] [116/156] (528s left) kms_psr (fbc-psr-cursor-blt) [494.014056] Starting subtest: fbc-psr-cursor-blt [494.016385] Starting dynamic subtest: eDP-1 [494.020394] Dynamic subtest eDP-1: SKIP (0.000s) [494.024493] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [494.105657] [117/156] (528s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [494.205759] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [494.209441] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s) [494.280049] [118/156] (528s left) sw_sync (sync_random_merge) [494.313917] Starting subtest: sync_random_merge [494.358024] Subtest sync_random_merge: SUCCESS (0.046s) [494.433035] [119/156] (528s left) kms_psr (psr-primary-mmap-cpu) [494.517498] Starting subtest: psr-primary-mmap-cpu [494.519280] Starting dynamic subtest: eDP-1 [496.288747] Dynamic subtest eDP-1: SUCCESS (1.770s) [496.291208] Subtest psr-primary-mmap-cpu: SUCCESS (1.771s) [497.150736] [120/156] (525s left) kms_cursor_crc (cursor-offscreen-64x64) [497.333252] Starting subtest: cursor-offscreen-64x64 [497.337987] Starting dynamic subtest: pipe-A-eDP-1 [499.267764] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s) [499.298707] Starting dynamic subtest: pipe-D-eDP-1 [501.868509] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.576s) [501.870883] Subtest cursor-offscreen-64x64: SUCCESS (4.533s) [502.722715] [121/156] (519s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [502.784366] Starting subtest: invalid-multi-wait-all-unsubmitted [502.786624] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [502.882037] [122/156] (519s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-wc) [502.974846] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-wc [502.978794] Subtest fbcpsrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [503.070687] [123/156] (519s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [503.177894] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf [503.180239] Starting dynamic subtest: pipe-A-eDP-1 [503.261905] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s) [503.272922] Starting dynamic subtest: pipe-B-eDP-1 [504.388409] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s) [504.393299] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.215s) [505.587373] [124/156] (517s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [505.693579] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [505.697968] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [505.794785] [125/156] (517s left) kms_big_fb (4-tiled-addfb) [505.898696] Starting subtest: 4-tiled-addfb [505.901041] Subtest 4-tiled-addfb: SUCCESS (0.000s) [506.022138] [126/156] (516s left) kms_addfb_basic (basic) [506.077450] Starting subtest: basic [506.079418] Subtest basic: SUCCESS (0.000s) [506.217153] [127/156] (516s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt) [506.313498] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt [506.317420] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [506.412835] [128/156] (516s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [506.501745] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [506.505197] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [506.604647] [129/156] (516s left) kms_vrr (negative-basic) [506.701930] Starting subtest: negative-basic [506.707520] Starting dynamic subtest: pipe-A-eDP-1 [512.177613] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.414s) [512.403447] Subtest negative-basic: SUCCESS (5.700s) [513.212386] [130/156] (509s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [513.320525] Starting subtest: blocking-absolute-wf_vblank-interruptible [513.322867] Starting dynamic subtest: A-eDP1 [522.103689] Dynamic subtest A-eDP1: SUCCESS (8.747s) [522.113395] Starting dynamic subtest: B-eDP1 [530.844559] Dynamic subtest B-eDP1: SUCCESS (8.740s) [530.854837] Starting dynamic subtest: C-eDP1 [539.584706] Dynamic subtest C-eDP1: SUCCESS (8.724s) [539.596965] Starting dynamic subtest: D-eDP1 [548.319178] Dynamic subtest D-eDP1: SUCCESS (8.732s) [548.321678] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.957s) [549.491612] [131/156] (473s left) kms_atomic_transition (plane-all-transition-fencing) [549.598332] Starting subtest: plane-all-transition-fencing [549.600878] Starting dynamic subtest: pipe-A-eDP-1 [552.091524] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s) [552.397761] Starting dynamic subtest: pipe-B-eDP-1 [555.621910] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.233s) [555.919015] Subtest plane-all-transition-fencing: SUCCESS (6.323s) [556.758957] [132/156] (466s left) gem_mmap_gtt (cpuset-medium-copy-xy) [556.818822] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [556.876603] [133/156] (466s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [556.961072] Starting subtest: modeset-transition-nonblocking-fencing [556.963212] Starting dynamic subtest: 1x-outputs [568.099630] Dynamic subtest 1x-outputs: SUCCESS (11.140s) [568.102081] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.142s) [568.948538] [134/156] (454s left) gem_exec_reloc (basic-cpu-gtt) [569.009443] Subtest basic-cpu-gtt: SKIP (0.000s) [569.091976] [135/156] (454s left) syncobj_timeline (invalid-signal-illegal-point) [569.150071] Starting subtest: invalid-signal-illegal-point [569.152294] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [569.247587] [136/156] (454s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [569.344168] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [569.348442] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [569.445319] [137/156] (453s left) syncobj_wait (wait-for-submit-complex) [569.501068] Starting subtest: wait-for-submit-complex [569.563367] Subtest wait-for-submit-complex: SUCCESS (0.062s) [569.642080] [138/156] (453s left) gem_exec_reloc (basic-wc) [569.710831] Subtest basic-wc: SKIP (0.000s) [569.777151] [139/156] (453s left) prime_mmap_coherency (read) [569.844399] Starting subtest: read [575.223616] Subtest read: SUCCESS (5.378s) [575.347500] [140/156] (448s left) api_intel_bb (simple-bb) [575.406205] Starting subtest: simple-bb [575.416090] Subtest simple-bb: SUCCESS (0.010s) [575.526847] [141/156] (447s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc) [575.625679] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc [575.629779] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [575.733089] [142/156] (447s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [576.113870] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [576.955980] [143/156] (446s left) kms_sequence (get-idle) [577.041165] Starting subtest: get-idle [577.043522] Starting dynamic subtest: pipe-A-eDP-1 [578.851745] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.809s) [578.863102] Starting dynamic subtest: pipe-B-eDP-1 [581.357241] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.506s) [581.370815] Starting dynamic subtest: pipe-C-eDP-1 [583.868629] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.505s) [583.878888] Starting dynamic subtest: pipe-D-eDP-1 [586.301059] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.432s) [586.303732] Subtest get-idle: SUCCESS (9.261s) [587.111640] [144/156] (436s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [587.210130] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [587.222045] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [587.330415] [145/156] (436s left) prime_mmap (test_invalid_sync_flags) [587.391186] Starting subtest: test_invalid_sync_flags [587.393082] Starting dynamic subtest: test_invalid_sync_flags-smem [587.395353] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s) [587.397521] Subtest test_invalid_sync_flags: SUCCESS (0.001s) [587.487777] [146/156] (436s left) kms_color_pipeline (plane-lut1d-ctm3x4) [587.585111] Starting subtest: plane-lut1d-ctm3x4 [587.755040] Starting dynamic subtest: pipe-A-plane-0 [587.909053] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s) [587.919588] Starting dynamic subtest: pipe-A-plane-1 [588.063938] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s) [588.073702] Starting dynamic subtest: pipe-A-plane-2 [588.253139] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s) [589.414050] Starting dynamic subtest: pipe-B-plane-0 [589.582945] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s) [589.595563] Starting dynamic subtest: pipe-B-plane-1 [589.738966] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s) [589.750356] Starting dynamic subtest: pipe-B-plane-2 [589.905264] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [591.168910] Starting dynamic subtest: pipe-C-plane-0 [591.314950] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [591.325324] Starting dynamic subtest: pipe-C-plane-1 [591.460026] Dynamic subtest pipe-C-plane-1: SUCCESS (0.143s) [591.471301] Starting dynamic subtest: pipe-C-plane-2 [591.615981] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [592.776444] Starting dynamic subtest: pipe-D-plane-0 [592.912642] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [592.926788] Starting dynamic subtest: pipe-D-plane-1 [593.068286] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [593.078659] Starting dynamic subtest: pipe-D-plane-2 [593.223411] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [593.511812] Subtest plane-lut1d-ctm3x4: SUCCESS (5.927s) [594.351303] [147/156] (429s left) gem_exec_balancer (individual) [594.409726] Starting subtest: individual [596.293584] Subtest individual: SUCCESS (1.882s) [596.621968] [148/156] (427s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc) [596.732715] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc [596.736810] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [596.825798] [149/156] (427s left) kms_dsc (dsc-fractional-bpp) [596.924364] Starting subtest: dsc-fractional-bpp [596.937532] Subtest dsc-fractional-bpp: SKIP (0.000s) [596.996961] [150/156] (426s left) gem_exec_basic (basic) [597.047970] Starting subtest: basic [597.050477] Starting dynamic subtest: rcs0-smem [597.052654] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [597.065323] Starting dynamic subtest: bcs0-smem [597.067127] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [597.076975] Starting dynamic subtest: vcs0-smem [597.078845] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [597.088531] Starting dynamic subtest: vcs1-smem [597.090411] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [597.099743] Starting dynamic subtest: vecs0-smem [597.101647] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [597.111158] Starting dynamic subtest: ccs0-smem [597.113046] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [597.114972] Subtest basic: SUCCESS (0.016s) [598.345511] [151/156] (425s left) perf_pmu (busy-accuracy-2) [598.383079] Starting subtest: busy-accuracy-2 [598.385544] Starting dynamic subtest: rcs0 [601.479535] Dynamic subtest rcs0: SUCCESS (3.047s) [601.491846] Starting dynamic subtest: bcs0 [604.536036] Dynamic subtest bcs0: SUCCESS (3.053s) [604.548655] Starting dynamic subtest: vcs0 [607.580259] Dynamic subtest vcs0: SUCCESS (3.044s) [607.591058] Starting dynamic subtest: vcs1 [610.623650] Dynamic subtest vcs1: SUCCESS (3.041s) [610.635215] Starting dynamic subtest: vecs0 [613.669494] Dynamic subtest vecs0: SUCCESS (3.044s) [613.681582] Starting dynamic subtest: ccs0 [616.679977] Dynamic subtest ccs0: SUCCESS (3.057s) [616.682566] Subtest busy-accuracy-2: SUCCESS (18.298s) [616.807485] [152/156] (407s left) perf (non-sampling-read-error) [616.959312] Starting subtest: non-sampling-read-error [616.972267] Subtest non-sampling-read-error: SUCCESS (0.011s) [617.012024] [153/156] (406s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [617.110808] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [624.075872] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.971s) [624.213852] [154/156] (399s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [624.307392] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [624.311653] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [624.405448] [155/156] (399s left) kms_psr (pr-sprite-plane-onoff) [624.496393] Starting subtest: pr-sprite-plane-onoff [624.500337] Subtest pr-sprite-plane-onoff: SKIP (0.000s) [624.574100] [156/156] (399s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [624.665647] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [624.669787] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [624.756681] Closing watchdogs results: parsing output: 0/ for test: gem_mmap_wc results: parsing output: 1/ for test: kms_hdr results: parsing output: 2/ for test: gem_exec_schedule results: parsing output: 3/ for test: gem_exec_reloc results: parsing output: 4/ for test: gem_render_copy results: parsing output: 5/ for test: gem_exec_parallel results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: gen9_exec_parse results: parsing output: 11/ for test: i915_pciid results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: gem_exec_fence results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: gem_userptr_blits results: parsing output: 16/ for test: kms_big_fb results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_ctx_param results: parsing output: 19/ for test: kms_rmfb results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_cursor_crc results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: i915_suspend results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_getfb 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_lease results: parsing output: 29/ for test: gem_ccs results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_chamelium_frames results: parsing output: 32/ for test: kms_cursor_legacy results: parsing output: 33/ for test: kms_plane_multiple results: parsing output: 34/ for test: kms_plane_scaling results: parsing output: 35/ for test: kms_cdclk results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: kms_plane results: parsing output: 38/ for test: gem_exec_fence results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: gem_lmem_swapping results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: kms_joiner results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: api_intel_allocator results: parsing output: 46/ for test: kms_flip results: parsing output: 47/ for test: kms_cursor_legacy results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_scaling_modes results: parsing output: 50/ for test: prime_self_import results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: kms_content_protection results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: kms_pm_rpm results: parsing output: 59/ for test: perf_pmu results: parsing output: 60/ for test: kms_busy results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_rotation_crc results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_cursor_legacy results: parsing output: 66/ for test: syncobj_timeline results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: kms_addfb_basic results: parsing output: 69/ for test: kms_flip results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_eio results: parsing output: 73/ for test: gem_ctx_persistence results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: i915_query results: parsing output: 76/ for test: gem_mmap_offset results: parsing output: 77/ for test: i915_drm_fdinfo results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: sysfs_timeslice_duration results: parsing output: 82/ for test: gem_exec_store results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_plane_alpha_blend results: parsing output: 85/ for test: kms_cursor_crc results: parsing output: 86/ for test: syncobj_timeline results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: gem_ctx_persistence results: parsing output: 91/ for test: syncobj_wait results: parsing output: 92/ for test: kms_flip_scaled_crc results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_mmap_wc results: parsing output: 95/ for test: dmabuf_sync_file results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: i915_pm_rps results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: syncobj_timeline results: parsing output: 100/ for test: gem_busy results: parsing output: 101/ for test: gem_render_copy results: parsing output: 102/ for test: kms_psr2_sf results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_psr2_sf results: parsing output: 105/ for test: gem_workarounds results: parsing output: 106/ for test: kms_prop_blob results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: syncobj_eventfd results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_pm_backlight results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_exec_reloc results: parsing output: 113/ for test: gem_softpin results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_flip_scaled_crc results: parsing output: 117/ for test: sw_sync results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_cursor_crc results: parsing output: 120/ for test: syncobj_wait results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_psr2_sf results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: kms_addfb_basic results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_vrr results: parsing output: 129/ for test: kms_flip results: parsing output: 130/ for test: kms_atomic_transition results: parsing output: 131/ for test: gem_mmap_gtt results: parsing output: 132/ for test: kms_atomic_transition results: parsing output: 133/ for test: gem_exec_reloc results: parsing output: 134/ for test: syncobj_timeline results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: syncobj_wait results: parsing output: 137/ for test: gem_exec_reloc results: parsing output: 138/ for test: prime_mmap_coherency results: parsing output: 139/ for test: api_intel_bb results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: kms_chamelium_hpd results: parsing output: 142/ for test: kms_sequence results: parsing output: 143/ for test: kms_flip results: parsing output: 144/ for test: prime_mmap results: parsing output: 145/ for test: kms_color_pipeline results: parsing output: 146/ for test: gem_exec_balancer results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_dsc results: parsing output: 149/ for test: gem_exec_basic results: parsing output: 150/ for test: perf_pmu results: parsing output: 151/ for test: perf results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: kms_psr results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.