[62.506548] Initializing watchdogs [62.506614] /dev/watchdog0 [62.526347] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [62.537211] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [62.540803] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.542995] [001/128] (960s left) kms_psr (fbc-psr-primary-page-flip) [62.730232] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [62.776557] [002/128] (960s left) kms_big_fb (x-tiled-16bpp-rotate-90) [62.968484] Starting subtest: x-tiled-16bpp-rotate-90 [63.043234] Subtest x-tiled-16bpp-rotate-90: SKIP (0.074s) [63.265623] [003/128] (959s left) kms_chamelium_color (ctm-0-50) [63.440655] Subtest ctm-0-50: SKIP (0.000s) [63.495209] [004/128] (959s left) kms_vblank (query-idle) [63.670403] Starting subtest: query-idle [63.672296] Starting dynamic subtest: pipe-A-DP-3 [65.971165] Dynamic subtest pipe-A-DP-3: SUCCESS (2.295s) [65.980450] Starting dynamic subtest: pipe-D-DP-3 [68.215439] Dynamic subtest pipe-D-DP-3: SUCCESS (2.238s) [68.216375] Subtest query-idle: SUCCESS (4.538s) [68.480173] [005/128] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [68.669389] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [68.671054] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [68.865895] [006/128] (954s left) gem_exec_await (wide-contexts) [69.140928] Starting subtest: wide-contexts [91.260954] Subtest wide-contexts: SUCCESS (22.112s) [91.517764] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true [91.520460] [007/128] (931s left) kms_flip (2x-plain-flip-ts-check) [91.758834] Starting subtest: 2x-plain-flip-ts-check [91.773599] Subtest 2x-plain-flip-ts-check: SKIP (0.014s) [91.935527] [008/128] (931s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [92.130329] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [92.177199] [009/128] (931s left) syncobj_timeline (invalid-signal-one-illegal-handle) [92.259701] Starting subtest: invalid-signal-one-illegal-handle [92.260577] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [92.427272] [010/128] (931s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [92.613949] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [92.614861] Starting dynamic subtest: pipe-A-valid-mode [92.697406] Dynamic subtest pipe-A-valid-mode: SKIP (0.082s) [92.699320] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.083s) [92.944629] [011/128] (930s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [93.022204] Starting subtest: invalid-smem-bo-on-discrete [93.023131] Subtest invalid-smem-bo-on-discrete: SUCCESS (0.000s) [93.311131] [012/128] (930s left) gem_ctx_exec (basic-norecovery) [93.390781] Starting subtest: basic-norecovery [93.779744] Subtest basic-norecovery: SUCCESS (0.388s) [94.016850] [013/128] (929s left) gem_exec_parallel (contexts) [94.115236] Starting subtest: contexts [94.116158] Starting dynamic subtest: rcs0 [98.667255] Dynamic subtest rcs0: SUCCESS (4.551s) [98.676935] Starting dynamic subtest: bcs0 [103.089767] Dynamic subtest bcs0: SUCCESS (4.422s) [103.099406] Starting dynamic subtest: vcs0 [107.067924] Dynamic subtest vcs0: SUCCESS (3.977s) [107.077524] Starting dynamic subtest: vcs1 [111.153573] Dynamic subtest vcs1: SUCCESS (4.085s) [111.163046] Starting dynamic subtest: vecs0 [115.289735] Dynamic subtest vecs0: SUCCESS (4.136s) [115.299039] Starting dynamic subtest: vecs1 [119.470239] Dynamic subtest vecs1: SUCCESS (4.180s) [119.480080] Starting dynamic subtest: ccs0 [124.123281] Dynamic subtest ccs0: SUCCESS (4.652s) [124.124323] Subtest contexts: SUCCESS (30.005s) [124.404847] [014/128] (899s left) kms_flip (2x-nonexisting-fb) [124.591590] Starting subtest: 2x-nonexisting-fb [124.605489] Subtest 2x-nonexisting-fb: SKIP (0.014s) [124.782526] [015/128] (899s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [124.972586] Starting subtest: plane-upscale-factor-0-25-with-modifiers [124.973447] Starting dynamic subtest: pipe-A [125.540788] Dynamic subtest pipe-A: SUCCESS (0.567s) [125.559491] Starting dynamic subtest: pipe-B [126.188133] Dynamic subtest pipe-B: SUCCESS (0.648s) [126.197876] Starting dynamic subtest: pipe-C [126.819689] Dynamic subtest pipe-C: SUCCESS (0.631s) [126.839447] Starting dynamic subtest: pipe-D [127.466615] Dynamic subtest pipe-D: SUCCESS (0.646s) [127.467798] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.494s) [127.840968] [016/128] (896s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [128.034504] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [128.036257] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [128.224258] [017/128] (895s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [128.408126] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [128.408922] Starting dynamic subtest: pipe-A [130.497031] Dynamic subtest pipe-A: SUCCESS (2.088s) [130.516702] Starting dynamic subtest: pipe-B [132.745499] Dynamic subtest pipe-B: SUCCESS (2.248s) [132.763384] Starting dynamic subtest: pipe-C [133.059229] Dynamic subtest pipe-C: SUCCESS (0.313s) [133.083915] Starting dynamic subtest: pipe-D [133.372020] Dynamic subtest pipe-D: SUCCESS (0.312s) [133.373023] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (4.964s) [133.720596] [018/128] (890s left) kms_psr (psr-cursor-mmap-gtt) [133.910416] Subtest psr-cursor-mmap-gtt: SKIP (0.000s) [133.962687] [019/128] (890s left) syncobj_basic (illegal-fd-to-handle) [134.041063] Starting subtest: illegal-fd-to-handle [134.042139] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [134.236116] [020/128] (890s left) gem_exec_whisper (basic-queues-forked) [134.324875] Starting subtest: basic-queues-forked [156.866096] Subtest basic-queues-forked: SUCCESS (22.540s) [157.144817] [021/128] (867s left) kms_chamelium_frames (dp-crc-single) [157.417765] Subtest dp-crc-single: SKIP (0.000s) [157.571614] [022/128] (866s left) syncobj_timeline (reset-during-wait-for-submit) [157.653488] Starting subtest: reset-during-wait-for-submit [157.756294] Subtest reset-during-wait-for-submit: SUCCESS (0.103s) [157.924494] [023/128] (866s left) gem_userptr_blits (probe) [158.021496] Starting subtest: probe [158.140834] Subtest probe: SUCCESS (0.119s) [158.308432] [024/128] (866s left) i915_pm_rpm (gem-mmap-type) [160.036115] Starting subtest: gem-mmap-type [160.037116] Starting dynamic subtest: fixed-lmem0 [161.486676] Dynamic subtest fixed-lmem0: SUCCESS (1.451s) [161.508940] Starting dynamic subtest: fixed-smem0 [162.728668] Dynamic subtest fixed-smem0: SUCCESS (1.241s) [162.729931] Subtest gem-mmap-type: SUCCESS (2.695s) [162.993959] [025/128] (861s left) gem_eio (in-flight-contexts-10ms) [163.307310] Starting subtest: in-flight-contexts-10ms [176.935243] Subtest in-flight-contexts-10ms: SUCCESS (13.628s) [177.217657] [026/128] (847s left) syncobj_timeline (32bits-limit) [177.292141] Starting subtest: 32bits-limit [177.293013] Subtest 32bits-limit: SUCCESS (0.001s) [177.455391] [027/128] (847s left) gem_barrier_race (remote-request) [177.547856] Starting subtest: remote-request [177.548747] Starting dynamic subtest: rcs0 [182.842677] Dynamic subtest rcs0: SUCCESS (5.294s) [182.843517] Subtest remote-request: SUCCESS (5.295s) [183.062548] [028/128] (841s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [183.258532] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [183.260219] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [183.449904] [029/128] (841s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [183.649405] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [183.651262] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [183.833722] [030/128] (841s left) i915_power (sanity) [183.910228] Starting subtest: sanity [187.977224] Subtest sanity: SUCCESS (4.065s) [188.203150] [031/128] (837s left) gem_set_tiling_vs_gtt [188.350449] [032/128] (836s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [188.537862] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s) [188.599961] [033/128] (836s left) kms_plane_alpha_blend (alpha-basic) [188.789323] Starting subtest: alpha-basic [189.051136] Starting dynamic subtest: pipe-A-DP-3 [191.599096] Dynamic subtest pipe-A-DP-3: SUCCESS (2.547s) [191.631965] Starting dynamic subtest: pipe-D-DP-3 [194.313650] Dynamic subtest pipe-D-DP-3: SUCCESS (2.691s) [194.314727] Subtest alpha-basic: SUCCESS (5.524s) [194.646669] [034/128] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [194.835633] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [194.837274] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [195.031201] [035/128] (830s left) kms_flip (2x-plain-flip-ts-check-interruptible) [195.218660] Starting subtest: 2x-plain-flip-ts-check-interruptible [195.234107] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.014s) [195.410560] [036/128] (830s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [195.604110] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [195.619292] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.014s) [195.785701] [037/128] (829s left) api_intel_bb (purge-bb) [195.866192] Starting subtest: purge-bb [195.896168] Subtest purge-bb: SUCCESS (0.031s) [196.112603] [038/128] (829s left) kms_psr (fbc-pr-cursor-blt) [196.298535] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [196.358422] [039/128] (829s left) prime_busy (before) [196.439189] Starting subtest: before [196.443635] Starting dynamic subtest: rcs0 [196.489412] Dynamic subtest rcs0: SUCCESS (0.046s) [196.500124] Starting dynamic subtest: bcs0 [196.550919] Dynamic subtest bcs0: SUCCESS (0.061s) [196.570984] Starting dynamic subtest: vcs0 [196.592997] Dynamic subtest vcs0: SUCCESS (0.041s) [196.618518] Starting dynamic subtest: vcs1 [196.634412] Dynamic subtest vcs1: SUCCESS (0.040s) [196.653885] Starting dynamic subtest: vecs0 [196.675161] Dynamic subtest vecs0: SUCCESS (0.040s) [196.690166] Starting dynamic subtest: vecs1 [196.716158] Dynamic subtest vecs1: SUCCESS (0.040s) [196.731171] Starting dynamic subtest: ccs0 [196.758197] Dynamic subtest ccs0: SUCCESS (0.041s) [196.872296] Subtest before: SUCCESS (0.432s) [197.081543] [040/128] (828s left) i915_drm_fdinfo (virtual-idle) [197.155239] Starting subtest: virtual-idle [200.750068] Subtest virtual-idle: SUCCESS (3.593s) [200.895020] [041/128] (825s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [201.089365] Starting subtest: extended-pageflip-modeset-hang-oldfb [201.091334] Starting dynamic subtest: pipe-A [208.926289] Dynamic subtest pipe-A: SUCCESS (7.834s) [208.938339] Starting dynamic subtest: pipe-D [216.769901] Dynamic subtest pipe-D: SUCCESS (7.840s) [216.770796] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.680s) [217.058660] [042/128] (808s left) kms_setmode (invalid-clone-single-crtc) [217.137373] Starting subtest: invalid-clone-single-crtc [217.140189] Subtest invalid-clone-single-crtc: SKIP (0.000s) [217.289169] [043/128] (808s left) gem_fence_thrash (bo-write-verify-y) [217.334348] Starting subtest: bo-write-verify-y [217.365966] Subtest bo-write-verify-y: SKIP (0.031s) [217.442269] [044/128] (808s left) kms_frontbuffer_tracking (fbc-2p-rte) [217.635870] Starting subtest: fbc-2p-rte [217.637462] Subtest fbc-2p-rte: SKIP (0.000s) [217.840369] [045/128] (808s left) kms_atomic (atomic-invalid-params) [218.024949] Starting subtest: atomic-invalid-params [218.027143] Starting dynamic subtest: pipe-A-DP-3 [218.601052] Dynamic subtest pipe-A-DP-3: SUCCESS (0.574s) [218.602035] Subtest atomic-invalid-params: SUCCESS (0.576s) [218.905918] [046/128] (807s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [219.094768] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [219.095629] Starting dynamic subtest: pipe-A-DP-3 [219.104961] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [219.115447] Starting dynamic subtest: pipe-B-DP-3 [219.124666] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [219.134980] Starting dynamic subtest: pipe-C-DP-3 [219.144050] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [219.154518] Starting dynamic subtest: pipe-D-DP-3 [219.166573] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [219.168541] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.005s) [219.595312] [047/128] (806s left) kms_content_protection (atomic-dpms) [219.855881] Starting subtest: atomic-dpms [219.887616] Starting dynamic subtest: pipe-A-DP-3 [340.925470] Dynamic subtest pipe-A-DP-3: FAIL (120.874s) [340.926448] Subtest atomic-dpms: FAIL (121.011s) [341.130272] [048/128] (685s left) kms_psr (psr-sprite-blt) [341.321451] Subtest psr-sprite-blt: SKIP (0.000s) [341.376271] [049/128] (685s left) i915_query (query-topology-unsupported) [341.456280] Starting subtest: query-topology-unsupported [341.458365] Subtest query-topology-unsupported: SKIP (0.000s) [341.647773] [050/128] (684s left) gem_userptr_blits (access-control) [341.751581] Starting subtest: access-control [341.753476] Subtest access-control: SKIP (0.000s) [341.930736] [051/128] (684s left) gem_fence_thrash (bo-copy) [341.975433] Starting subtest: bo-copy [342.010057] Subtest bo-copy: SKIP (0.034s) [342.078630] [052/128] (684s left) kms_cursor_crc (cursor-rapid-movement-32x32) [342.362439] Starting subtest: cursor-rapid-movement-32x32 [342.413551] Subtest cursor-rapid-movement-32x32: SKIP (0.049s) [342.849390] [053/128] (683s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [343.039898] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [343.041646] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [343.246811] [054/128] (683s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [343.448482] Starting subtest: yf-tiled-64bpp-rotate-270 [343.450251] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [343.647578] [055/128] (683s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [343.845827] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [343.847446] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [344.035262] [056/128] (682s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [344.225273] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [344.226174] Starting dynamic subtest: pipe-A-DP-3 [344.234379] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [344.245041] Starting dynamic subtest: pipe-B-DP-3 [344.253378] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [344.263915] Starting dynamic subtest: pipe-C-DP-3 [344.272144] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [344.282532] Starting dynamic subtest: pipe-D-DP-3 [344.293132] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [344.295064] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s) [344.707867] [057/128] (682s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [344.897914] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [348.128570] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.231s) [348.324699] [058/128] (678s left) gem_eio (wait-immediate) [348.641484] Starting subtest: wait-immediate [349.247943] Subtest wait-immediate: SUCCESS (0.607s) [349.540660] [059/128] (677s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [349.731989] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [349.733791] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [349.927481] [060/128] (677s left) gem_exec_suspend (basic-s3) [350.016581] Starting subtest: basic-S3 [350.017462] Starting dynamic subtest: smem [372.718824] Dynamic subtest smem: SUCCESS (7.361s) [372.732536] Starting dynamic subtest: lmem0 [395.714594] Dynamic subtest lmem0: SUCCESS (7.278s) [395.715778] Subtest basic-S3: SUCCESS (14.641s) [396.002663] [061/128] (631s left) gem_workarounds (suspend-resume) [396.106941] Starting subtest: suspend-resume [414.615844] Subtest suspend-resume: SUCCESS (3.568s) [414.767617] [062/128] (612s left) gem_exec_nop (basic-parallel) [414.861735] Starting subtest: basic-parallel [419.239317] Subtest basic-parallel: SUCCESS (4.378s) [419.573531] [063/128] (607s left) kms_big_fb (linear-8bpp-rotate-0) [419.766624] Starting subtest: linear-8bpp-rotate-0 [421.398682] Subtest linear-8bpp-rotate-0: SUCCESS (1.631s) [421.631698] [064/128] (605s left) kms_cursor_edge_walk (128x128-top-bottom) [421.834517] Starting subtest: 128x128-top-bottom [421.837019] Starting dynamic subtest: pipe-A-DP-3 [425.284087] Dynamic subtest pipe-A-DP-3: SUCCESS (3.446s) [425.303850] Starting dynamic subtest: pipe-D-DP-3 [428.601134] Dynamic subtest pipe-D-DP-3: SUCCESS (3.315s) [428.602082] Subtest 128x128-top-bottom: SUCCESS (6.766s) [428.919093] [065/128] (598s left) perf (whitelisted-registers-userspace-config) [429.186142] Starting subtest: whitelisted-registers-userspace-config [429.186973] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s) [429.248268] [066/128] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [429.439436] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [429.441273] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [429.638960] [067/128] (598s left) syncobj_wait (single-wait-for-submit-signaled) [429.715709] Starting subtest: single-wait-for-submit-signaled [429.716619] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [429.911242] [068/128] (597s left) gem_exec_schedule (thriceslice) [429.999775] Starting subtest: thriceslice [430.000670] Starting dynamic subtest: rcs0 [430.030311] Dynamic subtest rcs0: SUCCESS (0.030s) [430.042862] Starting dynamic subtest: bcs0 [430.062398] Dynamic subtest bcs0: SUCCESS (0.031s) [430.075169] Starting dynamic subtest: vcs0 [430.115257] Dynamic subtest vcs0: SUCCESS (0.052s) [430.141056] Starting dynamic subtest: vcs1 [430.152358] Dynamic subtest vcs1: SUCCESS (0.036s) [430.177535] Starting dynamic subtest: vecs0 [430.192555] Dynamic subtest vecs0: SUCCESS (0.038s) [430.212620] Starting dynamic subtest: vecs1 [430.248137] Dynamic subtest vecs1: SUCCESS (0.054s) [430.284790] Starting dynamic subtest: ccs0 [430.293846] Dynamic subtest ccs0: SUCCESS (0.044s) [430.294872] Subtest thriceslice: SUCCESS (0.295s) [430.702186] [069/128] (597s left) core_hotunplug (unbind-rebind) [430.836319] Starting subtest: unbind-rebind [434.560659] Subtest unbind-rebind: SUCCESS (3.726s) [434.610521] [070/128] (593s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [434.897360] Starting subtest: fbc-rgb101010-draw-mmap-wc [434.899038] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s) [435.099878] [071/128] (593s left) kms_pm_rpm (dpms-mode-unset-lpsp) [437.029921] Starting subtest: dpms-mode-unset-lpsp [437.375748] Subtest dpms-mode-unset-lpsp: SKIP (0.344s) [437.850084] [072/128] (590s left) kms_hdr (static-toggle) [438.035721] Starting subtest: static-toggle [438.608070] Starting dynamic subtest: pipe-A-DP-3 [439.636663] Dynamic subtest pipe-A-DP-3: SUCCESS (1.035s) [439.640635] Subtest static-toggle: SUCCESS (1.603s) [440.034251] [073/128] (588s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite) [440.227402] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite [440.229078] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [440.433959] [074/128] (587s left) kms_flip (dpms-vs-vblank-race) [440.620707] Starting subtest: dpms-vs-vblank-race [440.625304] Starting dynamic subtest: A-DP3 [443.924691] Dynamic subtest A-DP3: SUCCESS (3.298s) [443.951593] Starting dynamic subtest: B-DP3 [446.989658] Dynamic subtest B-DP3: SUCCESS (3.063s) [447.004855] Starting dynamic subtest: C-DP3 [450.021276] Dynamic subtest C-DP3: SUCCESS (3.029s) [450.045620] Starting dynamic subtest: D-DP3 [453.072775] Dynamic subtest D-DP3: SUCCESS (3.049s) [453.075412] Subtest dpms-vs-vblank-race: SUCCESS (12.453s) [453.419839] [075/128] (575s left) kms_prop_blob (invalid-get-prop-any) [453.503992] Starting subtest: invalid-get-prop-any [453.505692] Subtest invalid-get-prop-any: SUCCESS (0.000s) [453.657213] [076/128] (574s left) gem_exec_params (rel-constants-invalid-ring) [453.741679] Starting subtest: rel-constants-invalid-ring [453.742612] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [453.965397] [077/128] (574s left) i915_drm_fdinfo (memory-info-idle) [454.034633] Starting subtest: memory-info-idle [454.035606] Starting dynamic subtest: lmem0 [454.137060] Dynamic subtest lmem0: SUCCESS (0.102s) [454.160370] Starting dynamic subtest: smem0 [454.180143] Dynamic subtest smem0: SUCCESS (0.041s) [454.181165] Subtest memory-info-idle: SUCCESS (0.146s) [454.321026] [078/128] (574s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [454.510633] Starting subtest: fbcpsr-slowdraw [454.512378] Subtest fbcpsr-slowdraw: SKIP (0.000s) [454.702387] [079/128] (574s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [454.909512] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [454.911316] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [455.117816] [080/128] (573s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [455.309641] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [455.311437] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [455.507175] [081/128] (573s left) kms_setmode (basic-clone-single-crtc) [455.582969] Starting subtest: basic-clone-single-crtc [455.585539] Subtest basic-clone-single-crtc: SKIP (0.000s) [455.748770] [082/128] (573s left) drm_read (invalid-buffer) [456.016401] Starting subtest: invalid-buffer [456.017337] Subtest invalid-buffer: SUCCESS (0.000s) [456.284112] [083/128] (572s left) kms_vrr (flip-basic-fastset) [456.471384] Starting subtest: flip-basic-fastset [456.473946] Subtest flip-basic-fastset: SKIP (0.000s) [456.638106] [084/128] (572s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [456.830626] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [456.832499] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s) [457.019415] [085/128] (572s left) gem_mmap_offset (bad-object) [457.101984] Starting subtest: bad-object [457.102886] Subtest bad-object: SUCCESS (0.000s) [457.301123] [086/128] (572s left) syncobj_timeline (single-wait-available-signaled) [457.378934] Starting subtest: single-wait-available-signaled [457.379832] Subtest single-wait-available-signaled: SUCCESS (0.000s) [457.586092] [087/128] (571s left) perf_pmu (most-busy-check-all) [457.656863] Starting subtest: most-busy-check-all [457.657754] Starting dynamic subtest: rcs0 [458.249023] Dynamic subtest rcs0: SUCCESS (0.593s) [458.267636] Starting dynamic subtest: bcs0 [458.803671] Dynamic subtest bcs0: SUCCESS (0.552s) [458.820203] Starting dynamic subtest: vcs0 [459.358721] Dynamic subtest vcs0: SUCCESS (0.553s) [459.377707] Starting dynamic subtest: vcs1 [459.913918] Dynamic subtest vcs1: SUCCESS (0.550s) [459.933008] Starting dynamic subtest: vecs0 [460.470829] Dynamic subtest vecs0: SUCCESS (0.552s) [460.489713] Starting dynamic subtest: vecs1 [461.028516] Dynamic subtest vecs1: SUCCESS (0.553s) [461.044758] Starting dynamic subtest: ccs0 [461.579901] Dynamic subtest ccs0: SUCCESS (0.549s) [461.584704] Subtest most-busy-check-all: SUCCESS (3.926s) [461.770018] [088/128] (567s left) gem_exec_big (single) [461.852882] Starting subtest: single [467.527604] Subtest single: SUCCESS (5.675s) [468.350059] [089/128] (561s left) kms_psr (pr-sprite-mmap-gtt) [468.579100] Subtest pr-sprite-mmap-gtt: SKIP (0.000s) [468.645254] [090/128] (560s left) perf_pmu (busy-idle) [468.717901] Starting subtest: busy-idle [468.718895] Starting dynamic subtest: rcs0 [469.485542] Dynamic subtest rcs0: SUCCESS (0.768s) [469.501044] Starting dynamic subtest: bcs0 [470.182630] Dynamic subtest bcs0: SUCCESS (0.695s) [470.200698] Starting dynamic subtest: vcs0 [470.857907] Dynamic subtest vcs0: SUCCESS (0.671s) [470.879406] Starting dynamic subtest: vcs1 [471.524108] Dynamic subtest vcs1: SUCCESS (0.662s) [471.542126] Starting dynamic subtest: vecs0 [472.193906] Dynamic subtest vecs0: SUCCESS (0.665s) [472.215970] Starting dynamic subtest: vecs1 [472.862125] Dynamic subtest vecs1: SUCCESS (0.664s) [472.884683] Starting dynamic subtest: ccs0 [473.534118] Dynamic subtest ccs0: SUCCESS (0.667s) [473.540152] Subtest busy-idle: SUCCESS (4.819s) [473.752175] [091/128] (555s left) gem_exec_balancer (invalid-bonds) [473.839824] Starting subtest: invalid-bonds [473.842045] Subtest invalid-bonds: SKIP (0.000s) [474.302439] [092/128] (555s left) kms_chamelium_hpd (dp-hpd-fast) [474.561854] Subtest dp-hpd-fast: SKIP (0.000s) [474.714256] [093/128] (555s left) api_intel_allocator (reloc-allocator) [474.790210] Starting subtest: reloc-allocator [474.791107] Starting dynamic subtest: basic [474.819347] Dynamic subtest basic: SUCCESS (0.030s) [474.835666] Starting dynamic subtest: parallel-one [474.836497] Dynamic subtest parallel-one: SUCCESS (0.004s) [474.850994] Starting dynamic subtest: print [474.852043] Dynamic subtest print: SUCCESS (0.000s) [474.866837] Starting dynamic subtest: reuse [474.868121] Dynamic subtest reuse: SUCCESS (0.000s) [474.882255] Starting dynamic subtest: fork-reopen-allocator [474.883429] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [474.884689] Subtest reloc-allocator: SUCCESS (0.053s) [475.073371] [094/128] (554s left) syncobj_wait (multi-wait-all-signaled) [475.157866] Starting subtest: multi-wait-all-signaled [475.158870] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [475.300831] [095/128] (554s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [475.383914] Starting subtest: etime-single-wait-for-submit-unsubmitted [475.489941] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.105s) [475.669915] [096/128] (554s left) gen9_exec_parse (batch-invalid-length) [475.752637] Subtest batch-invalid-length: SKIP (0.000s) [475.833041] [097/128] (554s left) gem_exec_fence (syncobj-signal) [476.406533] Starting subtest: syncobj-signal [476.435256] Subtest syncobj-signal: SUCCESS (0.028s) [476.890995] [098/128] (553s left) gem_exec_whisper (basic-fds-priority) [476.983242] Starting subtest: basic-fds-priority [499.876074] Subtest basic-fds-priority: SUCCESS (22.891s) [500.168133] [099/128] (530s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [500.352942] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [500.353820] Starting dynamic subtest: pipe-A-DP-3 [500.362383] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [500.376599] Starting dynamic subtest: pipe-B-DP-3 [500.385346] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [500.399280] Starting dynamic subtest: pipe-C-DP-3 [500.407690] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [500.421917] Starting dynamic subtest: pipe-D-DP-3 [500.432806] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [500.435025] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s) [500.844511] [100/128] (529s left) gem_exec_params (batch-first) [500.929059] Starting subtest: batch-first [500.959644] Subtest batch-first: SUCCESS (0.030s) [501.190160] [101/128] (529s left) kms_flip_tiling (flip-change-tiling) [501.377948] Starting subtest: flip-change-tiling [501.378872] Starting dynamic subtest: pipe-A-DP-3-4-to-4 [501.663772] Dynamic subtest pipe-A-DP-3-4-to-4: SUCCESS (0.285s) [501.686186] Starting dynamic subtest: pipe-A-DP-3-4-to-x [501.863401] Dynamic subtest pipe-A-DP-3-4-to-x: SUCCESS (0.196s) [501.910089] Starting dynamic subtest: pipe-A-DP-3-4-to-linear [502.080736] Dynamic subtest pipe-A-DP-3-4-to-linear: SUCCESS (0.214s) [502.129529] Starting dynamic subtest: pipe-A-DP-3-x-to-4 [502.297429] Dynamic subtest pipe-A-DP-3-x-to-4: SUCCESS (0.212s) [502.320122] Starting dynamic subtest: pipe-A-DP-3-x-to-x [502.463840] Dynamic subtest pipe-A-DP-3-x-to-x: SUCCESS (0.162s) [502.513030] Starting dynamic subtest: pipe-A-DP-3-x-to-linear [502.680943] Dynamic subtest pipe-A-DP-3-x-to-linear: SUCCESS (0.212s) [502.731736] Starting dynamic subtest: pipe-A-DP-3-linear-to-4 [502.896389] Dynamic subtest pipe-A-DP-3-linear-to-4: SUCCESS (0.211s) [502.932206] Starting dynamic subtest: pipe-A-DP-3-linear-to-x [503.097840] Dynamic subtest pipe-A-DP-3-linear-to-x: SUCCESS (0.198s) [503.120744] Starting dynamic subtest: pipe-A-DP-3-linear-to-linear [503.263912] Dynamic subtest pipe-A-DP-3-linear-to-linear: SUCCESS (0.162s) [503.358315] Starting dynamic subtest: pipe-B-DP-3-4-to-4 [503.679043] Dynamic subtest pipe-B-DP-3-4-to-4: SUCCESS (0.359s) [503.729806] Starting dynamic subtest: pipe-B-DP-3-4-to-x [503.844749] Dynamic subtest pipe-B-DP-3-4-to-x: SUCCESS (0.162s) [503.873505] Starting dynamic subtest: pipe-B-DP-3-4-to-linear [503.994871] Dynamic subtest pipe-B-DP-3-4-to-linear: SUCCESS (0.148s) [504.036707] Starting dynamic subtest: pipe-B-DP-3-x-to-4 [504.161597] Dynamic subtest pipe-B-DP-3-x-to-4: SUCCESS (0.164s) [504.204953] Starting dynamic subtest: pipe-B-DP-3-x-to-x [504.328245] Dynamic subtest pipe-B-DP-3-x-to-x: SUCCESS (0.164s) [504.369593] Starting dynamic subtest: pipe-B-DP-3-x-to-linear [504.494897] Dynamic subtest pipe-B-DP-3-x-to-linear: SUCCESS (0.164s) [504.536753] Starting dynamic subtest: pipe-B-DP-3-linear-to-4 [504.661622] Dynamic subtest pipe-B-DP-3-linear-to-4: SUCCESS (0.164s) [504.682701] Starting dynamic subtest: pipe-B-DP-3-linear-to-x [504.811934] Dynamic subtest pipe-B-DP-3-linear-to-x: SUCCESS (0.147s) [504.858502] Starting dynamic subtest: pipe-B-DP-3-linear-to-linear [504.978225] Dynamic subtest pipe-B-DP-3-linear-to-linear: SUCCESS (0.163s) [505.026511] Starting dynamic subtest: pipe-C-DP-3-4-to-4 [505.344990] Dynamic subtest pipe-C-DP-3-4-to-4: SUCCESS (0.331s) [505.393315] Starting dynamic subtest: pipe-C-DP-3-4-to-x [505.510867] Dynamic subtest pipe-C-DP-3-4-to-x: SUCCESS (0.162s) [505.530195] Starting dynamic subtest: pipe-C-DP-3-4-to-linear [505.644156] Dynamic subtest pipe-C-DP-3-4-to-linear: SUCCESS (0.131s) [505.685303] Starting dynamic subtest: pipe-C-DP-3-x-to-4 [505.811058] Dynamic subtest pipe-C-DP-3-x-to-4: SUCCESS (0.164s) [505.851094] Starting dynamic subtest: pipe-C-DP-3-x-to-x [505.977769] Dynamic subtest pipe-C-DP-3-x-to-x: SUCCESS (0.164s) [506.024333] Starting dynamic subtest: pipe-C-DP-3-x-to-linear [506.144300] Dynamic subtest pipe-C-DP-3-x-to-linear: SUCCESS (0.164s) [506.164976] Starting dynamic subtest: pipe-C-DP-3-linear-to-4 [506.277431] Dynamic subtest pipe-C-DP-3-linear-to-4: SUCCESS (0.131s) [506.309577] Starting dynamic subtest: pipe-C-DP-3-linear-to-x [506.427602] Dynamic subtest pipe-C-DP-3-linear-to-x: SUCCESS (0.148s) [506.469379] Starting dynamic subtest: pipe-C-DP-3-linear-to-linear [506.594355] Dynamic subtest pipe-C-DP-3-linear-to-linear: SUCCESS (0.164s) [506.644631] Starting dynamic subtest: pipe-D-DP-3-4-to-4 [506.958146] Dynamic subtest pipe-D-DP-3-4-to-4: SUCCESS (0.328s) [507.007718] Starting dynamic subtest: pipe-D-DP-3-4-to-x [507.123824] Dynamic subtest pipe-D-DP-3-4-to-x: SUCCESS (0.162s) [507.156078] Starting dynamic subtest: pipe-D-DP-3-4-to-linear [507.273870] Dynamic subtest pipe-D-DP-3-4-to-linear: SUCCESS (0.148s) [507.309876] Starting dynamic subtest: pipe-D-DP-3-x-to-4 [507.423699] Dynamic subtest pipe-D-DP-3-x-to-4: SUCCESS (0.148s) [507.452651] Starting dynamic subtest: pipe-D-DP-3-x-to-x [507.574069] Dynamic subtest pipe-D-DP-3-x-to-x: SUCCESS (0.148s) [507.621651] Starting dynamic subtest: pipe-D-DP-3-x-to-linear [507.740634] Dynamic subtest pipe-D-DP-3-x-to-linear: SUCCESS (0.164s) [507.782480] Starting dynamic subtest: pipe-D-DP-3-linear-to-4 [507.890383] Dynamic subtest pipe-D-DP-3-linear-to-4: SUCCESS (0.148s) [507.918996] Starting dynamic subtest: pipe-D-DP-3-linear-to-x [508.040746] Dynamic subtest pipe-D-DP-3-linear-to-x: SUCCESS (0.148s) [508.081702] Starting dynamic subtest: pipe-D-DP-3-linear-to-linear [508.190769] Dynamic subtest pipe-D-DP-3-linear-to-linear: SUCCESS (0.147s) [508.223532] Subtest flip-change-tiling: SUCCESS (6.847s) [508.646188] [102/128] (521s left) kms_plane_lowres (tiling-x) [508.841340] Starting subtest: tiling-x [508.842277] Starting dynamic subtest: pipe-A-DP-3 [519.442692] Dynamic subtest pipe-A-DP-3: SUCCESS (10.600s) [519.580998] Starting dynamic subtest: pipe-B-DP-3 [529.489934] Dynamic subtest pipe-B-DP-3: SUCCESS (9.923s) [529.595606] Starting dynamic subtest: pipe-C-DP-3 [539.721309] Dynamic subtest pipe-C-DP-3: SUCCESS (10.139s) [539.825292] Starting dynamic subtest: pipe-D-DP-3 [549.966775] Dynamic subtest pipe-D-DP-3: SUCCESS (10.155s) [550.089898] Subtest tiling-x: SUCCESS (41.249s) [550.390778] [103/128] (480s left) gem_exec_flush (basic-wb-ro-before-default) [550.476504] Subtest basic-wb-ro-before-default: SKIP (0.000s) [550.577650] [104/128] (480s left) gem_ctx_engines (execute-allforone) [550.664900] Starting subtest: execute-allforone [550.705072] Subtest execute-allforone: SUCCESS (0.041s) [551.059437] [105/128] (479s left) kms_cursor_crc (cursor-offscreen-64x64) [551.381697] Starting subtest: cursor-offscreen-64x64 [551.385958] Starting dynamic subtest: pipe-A-DP-3 [553.937873] Dynamic subtest pipe-A-DP-3: SUCCESS (2.551s) [553.991539] Starting dynamic subtest: pipe-D-DP-3 [556.433981] Dynamic subtest pipe-D-DP-3: SUCCESS (2.456s) [556.434857] Subtest cursor-offscreen-64x64: SUCCESS (5.053s) [557.006081] [106/128] (473s left) kms_ccs (bad-rotation-90-y-tiled-ccs) [557.194889] Starting subtest: bad-rotation-90-y-tiled-ccs [557.195860] Starting dynamic subtest: pipe-A-DP-3 [557.204516] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [557.218940] Starting dynamic subtest: pipe-B-DP-3 [557.227696] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [557.241956] Starting dynamic subtest: pipe-C-DP-3 [557.250887] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [557.265226] Starting dynamic subtest: pipe-D-DP-3 [557.275504] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [557.277392] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.007s) [557.688055] [107/128] (473s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [557.764006] Starting subtest: multi-wait-all-for-submit-submitted-signaled [557.866080] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s) [558.055101] [108/128] (473s left) gem_ctx_persistence (heartbeat-stop) [558.140853] Starting subtest: heartbeat-stop [558.143092] Subtest heartbeat-stop: SKIP (0.000s) [558.341424] [109/128] (472s left) gem_exec_reloc (basic-gtt-noreloc) [558.424059] Subtest basic-gtt-noreloc: SKIP (0.000s) [558.502293] [110/128] (472s left) gem_reg_read (bad-register) [558.580328] Starting subtest: bad-register [558.581246] Subtest bad-register: SUCCESS (0.000s) [558.775131] [111/128] (472s left) kms_cursor_legacy (single-bo) [558.960892] Starting subtest: single-bo [558.961844] Starting dynamic subtest: pipe-A [564.341578] Dynamic subtest pipe-A: SUCCESS (5.380s) [564.356411] Starting dynamic subtest: pipe-B [569.721314] Dynamic subtest pipe-B: SUCCESS (5.378s) [569.735838] Starting dynamic subtest: pipe-C [575.100995] Dynamic subtest pipe-C: SUCCESS (5.378s) [575.115327] Starting dynamic subtest: pipe-D [580.480747] Dynamic subtest pipe-D: SUCCESS (5.378s) [580.495096] Starting dynamic subtest: all-pipes [585.860738] Dynamic subtest all-pipes: SUCCESS (5.379s) [585.861779] Subtest single-bo: SUCCESS (26.899s) [585.991542] [112/128] (445s left) gem_mmap_offset (ptrace) [586.071276] Starting subtest: ptrace [586.073694] Starting dynamic subtest: lmem0-fixed [586.181239] Dynamic subtest lmem0-fixed: SUCCESS (0.107s) [586.198902] Starting dynamic subtest: smem0-fixed [586.201267] Dynamic subtest smem0-fixed: SUCCESS (0.015s) [586.202201] Subtest ptrace: SUCCESS (0.131s) [586.387389] [113/128] (445s left) gem_userptr_blits (sync-unmap-after-close) [586.478521] Starting subtest: sync-unmap-after-close [586.499410] Subtest sync-unmap-after-close: SUCCESS (0.021s) [586.715550] [114/128] (444s left) gem_exec_fence (syncobj-unused-fence) [587.275274] Starting subtest: syncobj-unused-fence [587.305794] Subtest syncobj-unused-fence: SUCCESS (0.030s) [587.722484] [115/128] (443s left) gem_pread (snoop) [587.800740] Subtest snoop: SKIP (0.000s) [587.917878] [116/128] (443s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [588.104738] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [588.106596] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [588.314827] [117/128] (443s left) gem_render_copy (yf-tiled-ccs-to-linear) [588.399424] Starting subtest: yf-tiled-ccs-to-linear [588.401630] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [588.658268] [118/128] (443s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [588.734727] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [588.845032] [119/128] (443s left) gem_exec_params (rel-constants-invalid-rel-gen5) [588.928187] Starting subtest: rel-constants-invalid-rel-gen5 [588.929143] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [589.119115] [120/128] (442s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [589.308799] Starting subtest: cursorA-vs-flipA-atomic-transitions [600.297269] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.989s) [600.623097] [121/128] (431s left) kms_big_fb (4-tiled-64bpp-rotate-270) [600.821517] Starting subtest: 4-tiled-64bpp-rotate-270 [600.884173] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.062s) [601.104636] [122/128] (431s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [601.290034] Starting subtest: psr-rgb565-draw-pwrite [601.291739] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s) [601.503769] [123/128] (430s left) gem_exec_schedule (pi-ringfull) [601.722628] Starting subtest: pi-ringfull [601.723875] Starting dynamic subtest: rcs0 [601.748442] Dynamic subtest rcs0: SUCCESS (0.034s) [601.766220] Starting dynamic subtest: bcs0 [601.781972] Dynamic subtest bcs0: SUCCESS (0.032s) [601.799054] Starting dynamic subtest: vcs0 [601.813768] Dynamic subtest vcs0: SUCCESS (0.031s) [601.830789] Starting dynamic subtest: vcs1 [601.845312] Dynamic subtest vcs1: SUCCESS (0.030s) [601.862278] Starting dynamic subtest: vecs0 [601.878692] Dynamic subtest vecs0: SUCCESS (0.032s) [601.895607] Starting dynamic subtest: vecs1 [601.911856] Dynamic subtest vecs1: SUCCESS (0.032s) [601.929986] Starting dynamic subtest: ccs0 [601.942810] Dynamic subtest ccs0: SUCCESS (0.030s) [601.943719] Subtest pi-ringfull: SUCCESS (0.230s) [602.272262] [124/128] (430s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [602.356169] Starting subtest: y-tiled-ccs-to-yf-tiled [602.358060] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [602.620036] [125/128] (429s left) kms_feature_discovery (display-2x) [602.810359] Starting subtest: display-2x [602.812107] Subtest display-2x: SKIP (0.000s) [602.990643] [126/128] (429s left) gem_spin_batch (legacy) [603.094533] Starting subtest: legacy [603.095395] Starting dynamic subtest: default [606.355656] Dynamic subtest default: SUCCESS (3.257s) [606.379038] Starting dynamic subtest: render [609.598196] Dynamic subtest render: SUCCESS (3.237s) [609.622056] Starting dynamic subtest: bsd [612.840998] Dynamic subtest bsd: SUCCESS (3.236s) [612.861190] Starting dynamic subtest: bsd1 [616.082555] Dynamic subtest bsd1: SUCCESS (3.235s) [616.104524] Starting dynamic subtest: bsd2 [619.322790] Dynamic subtest bsd2: SUCCESS (3.235s) [619.345549] Starting dynamic subtest: blt [622.564408] Dynamic subtest blt: SUCCESS (3.236s) [622.588212] Starting dynamic subtest: vebox [625.806390] Dynamic subtest vebox: SUCCESS (3.236s) [625.808380] Subtest legacy: SUCCESS (22.712s) [626.121589] [127/128] (406s left) syncobj_wait (invalid-signal-bad-pad) [626.201847] Starting subtest: invalid-signal-bad-pad [626.202832] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [626.402901] [128/128] (406s left) kms_lease (lease-revoke) [626.587976] Starting subtest: lease-revoke [626.588879] Starting dynamic subtest: pipe-A-DP-3 [626.689839] Dynamic subtest pipe-A-DP-3: SUCCESS (0.101s) [626.706950] Starting dynamic subtest: pipe-B-DP-3 [626.763476] Dynamic subtest pipe-B-DP-3: SUCCESS (0.072s) [626.779156] Starting dynamic subtest: pipe-C-DP-3 [626.838807] Dynamic subtest pipe-C-DP-3: SUCCESS (0.072s) [626.853682] Starting dynamic subtest: pipe-D-DP-3 [626.912213] Dynamic subtest pipe-D-DP-3: SUCCESS (0.073s) [626.913049] Subtest lease-revoke: SUCCESS (0.326s) [627.137671] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: kms_big_fb results: parsing output: 2/ for test: kms_chamelium_color results: parsing output: 3/ for test: kms_vblank results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: gem_exec_await results: parsing output: 6/ for test: kms_flip results: parsing output: 7/ for test: kms_psr2_sf results: parsing output: 8/ for test: syncobj_timeline results: parsing output: 9/ for test: kms_flip_scaled_crc results: parsing output: 10/ for test: kms_addfb_basic results: parsing output: 11/ for test: gem_ctx_exec results: parsing output: 12/ for test: gem_exec_parallel results: parsing output: 13/ for test: kms_flip results: parsing output: 14/ for test: kms_plane_scaling results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_plane_scaling results: parsing output: 17/ for test: kms_psr results: parsing output: 18/ for test: syncobj_basic results: parsing output: 19/ for test: gem_exec_whisper results: parsing output: 20/ for test: kms_chamelium_frames results: parsing output: 21/ for test: syncobj_timeline results: parsing output: 22/ for test: gem_userptr_blits results: parsing output: 23/ for test: i915_pm_rpm results: parsing output: 24/ for test: gem_eio results: parsing output: 25/ for test: syncobj_timeline results: parsing output: 26/ for test: gem_barrier_race results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: i915_power results: parsing output: 30/ for test: gem_set_tiling_vs_gtt results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: kms_plane_alpha_blend results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_flip results: parsing output: 35/ for test: kms_flip results: parsing output: 36/ for test: api_intel_bb results: parsing output: 37/ for test: kms_psr results: parsing output: 38/ for test: prime_busy results: parsing output: 39/ for test: i915_drm_fdinfo results: parsing output: 40/ for test: kms_busy results: parsing output: 41/ for test: kms_setmode results: parsing output: 42/ for test: gem_fence_thrash results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_atomic results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_content_protection results: parsing output: 47/ for test: kms_psr results: parsing output: 48/ for test: i915_query results: parsing output: 49/ for test: gem_userptr_blits results: parsing output: 50/ for test: gem_fence_thrash results: parsing output: 51/ for test: kms_cursor_crc results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: kms_big_fb results: parsing output: 55/ for test: kms_ccs results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: gem_eio results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_exec_suspend results: parsing output: 60/ for test: gem_workarounds results: parsing output: 61/ for test: gem_exec_nop results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: kms_cursor_edge_walk results: parsing output: 64/ for test: perf results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: syncobj_wait results: parsing output: 67/ for test: gem_exec_schedule results: parsing output: 68/ for test: core_hotunplug results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_pm_rpm results: parsing output: 71/ for test: kms_hdr results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_flip results: parsing output: 74/ for test: kms_prop_blob results: parsing output: 75/ for test: gem_exec_params results: parsing output: 76/ for test: i915_drm_fdinfo results: parsing output: 77/ for test: kms_frontbuffer_tracking 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_setmode results: parsing output: 81/ for test: drm_read results: parsing output: 82/ for test: kms_vrr results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: gem_mmap_offset results: parsing output: 85/ for test: syncobj_timeline results: parsing output: 86/ for test: perf_pmu results: parsing output: 87/ for test: gem_exec_big results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: perf_pmu results: parsing output: 90/ for test: gem_exec_balancer results: parsing output: 91/ for test: kms_chamelium_hpd results: parsing output: 92/ for test: api_intel_allocator results: parsing output: 93/ for test: syncobj_wait results: parsing output: 94/ for test: syncobj_timeline results: parsing output: 95/ for test: gen9_exec_parse results: parsing output: 96/ for test: gem_exec_fence results: parsing output: 97/ for test: gem_exec_whisper results: parsing output: 98/ for test: kms_ccs results: parsing output: 99/ for test: gem_exec_params results: parsing output: 100/ for test: kms_flip_tiling results: parsing output: 101/ for test: kms_plane_lowres results: parsing output: 102/ for test: gem_exec_flush results: parsing output: 103/ for test: gem_ctx_engines results: parsing output: 104/ for test: kms_cursor_crc results: parsing output: 105/ for test: kms_ccs results: parsing output: 106/ for test: syncobj_wait results: parsing output: 107/ for test: gem_ctx_persistence results: parsing output: 108/ for test: gem_exec_reloc results: parsing output: 109/ for test: gem_reg_read results: parsing output: 110/ for test: kms_cursor_legacy results: parsing output: 111/ for test: gem_mmap_offset results: parsing output: 112/ for test: gem_userptr_blits results: parsing output: 113/ for test: gem_exec_fence results: parsing output: 114/ for test: gem_pread results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: gem_render_copy results: parsing output: 117/ for test: gem_mmap_gtt results: parsing output: 118/ for test: gem_exec_params results: parsing output: 119/ for test: kms_cursor_legacy results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gem_exec_schedule results: parsing output: 123/ for test: gem_render_copy results: parsing output: 124/ for test: kms_feature_discovery results: parsing output: 125/ for test: gem_spin_batch results: parsing output: 126/ for test: syncobj_wait results: parsing output: 127/ for test: kms_lease Done.