[26.600023] Initializing watchdogs [26.600095] /dev/watchdog0 [26.604476] [001/130] (960s left) kms_color (legacy-gamma) [26.691579] Starting subtest: legacy-gamma [26.693520] Starting dynamic subtest: pipe-A-HDMI-A-1 [27.011679] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.318s) [27.016153] Starting dynamic subtest: pipe-B-HDMI-A-1 [27.307823] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.294s) [27.312185] Starting dynamic subtest: pipe-C-HDMI-A-1 [27.592707] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.283s) [27.596951] Starting dynamic subtest: pipe-D-HDMI-A-1 [27.881480] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.288s) [27.882231] Subtest legacy-gamma: SUCCESS (1.190s) [27.975942] [002/130] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [28.065582] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [28.067239] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [28.137945] [003/130] (958s left) syncobj_timeline (invalid-signal-zero-handles) [28.166275] Starting subtest: invalid-signal-zero-handles [28.167047] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [28.206333] [004/130] (958s left) gem_exec_reloc (basic-cpu-read-noreloc) [28.245073] Starting subtest: basic-cpu-read-noreloc [28.248660] Subtest basic-cpu-read-noreloc: SUCCESS (0.003s) [28.340767] [005/130] (958s left) kms_properties (invalid-properties-legacy) [28.419953] Starting subtest: invalid-properties-legacy [28.695280] Subtest invalid-properties-legacy: SUCCESS (0.268s) [28.726237] [006/130] (958s left) gem_exec_capture (capture-invisible) [28.763146] Starting subtest: capture-invisible [28.764038] Starting dynamic subtest: smem0 [28.765557] Dynamic subtest smem0: SKIP (0.000s) [28.766874] Subtest capture-invisible: SKIP (0.000s) [28.840241] [007/130] (958s left) kms_chamelium_color (ctm-red-to-blue) [28.933701] Subtest ctm-red-to-blue: SKIP (0.000s) [28.952594] [008/130] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [29.033315] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [29.034680] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [29.085145] [009/130] (958s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [29.173828] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [29.175249] Starting dynamic subtest: pipe-A [29.305564] Dynamic subtest pipe-A: SUCCESS (0.132s) [29.309192] Starting dynamic subtest: pipe-B [29.439102] Dynamic subtest pipe-B: SUCCESS (0.133s) [29.443234] Starting dynamic subtest: pipe-C [29.563636] Dynamic subtest pipe-C: SUCCESS (0.124s) [29.567409] Starting dynamic subtest: pipe-D [29.688458] Dynamic subtest pipe-D: SUCCESS (0.125s) [29.689251] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.515s) [29.828568] [010/130] (957s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [29.915494] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s) [29.935214] [011/130] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [30.016909] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [30.018383] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [30.070398] [012/130] (957s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [30.158689] Starting subtest: 2x-long-flip-vs-cursor-atomic [30.161202] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s) [30.190142] [013/130] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [30.275555] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [30.277070] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [30.338205] [014/130] (956s left) drm_fdinfo (virtual-busy-idle-all) [30.378081] Starting subtest: virtual-busy-idle-all [30.993839] Subtest virtual-busy-idle-all: SUCCESS (0.612s) [31.029121] [015/130] (956s left) kms_psr (psr2-sprite-blt) [31.117653] Subtest psr2-sprite-blt: SKIP (0.000s) [31.135552] [016/130] (956s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [31.217817] Starting subtest: psr-rgb101010-draw-blt [31.219323] Subtest psr-rgb101010-draw-blt: SKIP (0.000s) [31.289337] [017/130] (955s left) kms_cursor_crc (cursor-onscreen-32x10) [31.381649] Starting subtest: cursor-onscreen-32x10 [31.425292] Subtest cursor-onscreen-32x10: SKIP (0.042s) [31.505022] [018/130] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [31.594553] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [31.595989] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [31.642010] [019/130] (955s left) syncobj_wait (single-wait-all-signaled) [31.671559] Starting subtest: single-wait-all-signaled [31.672358] Subtest single-wait-all-signaled: SUCCESS (0.000s) [31.708761] [020/130] (955s left) kms_psr (fbc-psr-sprite-mmap-gtt) [31.796736] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [31.810081] [021/130] (955s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [31.834394] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [31.935674] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.101s) [31.983648] [022/130] (955s left) kms_writeback (writeback-fb-id) [32.076786] Subtest writeback-fb-id: SKIP (0.000s) [32.093867] [023/130] (955s left) kms_prop_blob (invalid-get-prop) [32.118531] Starting subtest: invalid-get-prop [32.119356] Subtest invalid-get-prop: SUCCESS (0.000s) [32.153961] [024/130] (955s left) gem_exec_schedule (u-submit-early-slice) [32.187628] Starting subtest: u-submit-early-slice [32.188359] Starting dynamic subtest: rcs0 [32.216536] Dynamic subtest rcs0: SUCCESS (0.029s) [32.221569] Starting dynamic subtest: bcs0 [32.242597] Dynamic subtest bcs0: SUCCESS (0.026s) [32.246543] Starting dynamic subtest: vcs0 [32.265530] Dynamic subtest vcs0: SUCCESS (0.023s) [32.269269] Starting dynamic subtest: vcs1 [32.288473] Dynamic subtest vcs1: SUCCESS (0.023s) [32.292065] Starting dynamic subtest: vecs0 [32.312362] Dynamic subtest vecs0: SUCCESS (0.024s) [32.313137] Subtest u-submit-early-slice: SUCCESS (0.124s) [32.566957] [025/130] (954s left) gem_exec_parallel (engines) [32.607697] Starting subtest: engines [32.608479] Starting dynamic subtest: basic [34.004275] Dynamic subtest basic: SUCCESS (1.397s) [34.007966] Starting dynamic subtest: contexts [36.493783] Dynamic subtest contexts: SUCCESS (2.481s) [36.497791] Starting dynamic subtest: fds [38.368278] Dynamic subtest fds: SUCCESS (1.883s) [38.377692] Starting dynamic subtest: userptr [39.830055] Dynamic subtest userptr: SUCCESS (1.462s) [39.830802] Subtest engines: SUCCESS (7.223s) [39.994319] [026/130] (947s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [40.088880] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [40.090410] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [40.133691] [027/130] (947s left) kms_hdr (bpc-switch) [40.211888] Starting subtest: bpc-switch [40.214120] Subtest bpc-switch: SKIP (0.001s) [40.241980] [028/130] (947s left) gem_exec_fence (syncobj-invalid-flags) [40.582277] Starting subtest: syncobj-invalid-flags [40.583020] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [40.843717] [029/130] (946s left) kms_dsc (dsc-with-bpc) [40.932037] Starting subtest: dsc-with-bpc [40.933667] Subtest dsc-with-bpc: SKIP (0.001s) [40.967137] [030/130] (946s left) gem_wait (await) [40.999652] Starting subtest: await [41.000473] Starting dynamic subtest: all-engines [42.021523] Dynamic subtest all-engines: SUCCESS (1.022s) [42.029027] Starting dynamic subtest: rcs0 [43.043466] Dynamic subtest rcs0: SUCCESS (1.022s) [43.050841] Starting dynamic subtest: bcs0 [44.072688] Dynamic subtest bcs0: SUCCESS (1.029s) [44.079938] Starting dynamic subtest: vcs0 [45.098347] Dynamic subtest vcs0: SUCCESS (1.026s) [45.105984] Starting dynamic subtest: vcs1 [46.121202] Dynamic subtest vcs1: SUCCESS (1.021s) [46.128630] Starting dynamic subtest: vecs0 [47.141462] Dynamic subtest vecs0: SUCCESS (1.021s) [47.142499] Subtest await: SUCCESS (6.141s) [47.304684] [031/130] (940s left) kms_addfb_basic (bad-pitch-63) [47.340626] Starting subtest: bad-pitch-63 [47.341390] Subtest bad-pitch-63: SUCCESS (0.000s) [47.459378] [032/130] (939s left) sw_sync (sync_busy_fork_unixsocket) [47.488912] Starting subtest: sync_busy_fork_unixsocket [47.496500] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s) [47.518017] [033/130] (939s left) gem_mmap_wc (coherency) [47.542336] Starting subtest: coherency [47.600241] Subtest coherency: SUCCESS (0.059s) [47.646441] [034/130] (939s left) gem_mmap_offset (close-race) [47.680848] Starting subtest: close-race [67.756091] Subtest close-race: SUCCESS (20.042s) [67.797480] [035/130] (919s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [67.894768] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [67.896262] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s) [67.951943] [036/130] (919s left) gem_mmap_offset (ptrace) [67.988879] Starting subtest: ptrace [67.990544] Starting dynamic subtest: smem0-gtt [68.015285] Dynamic subtest smem0-gtt: SUCCESS (0.026s) [68.019335] Starting dynamic subtest: smem0-wb [68.029816] Dynamic subtest smem0-wb: SUCCESS (0.014s) [68.034280] Starting dynamic subtest: smem0-wc [68.046489] Dynamic subtest smem0-wc: SUCCESS (0.016s) [68.050898] Starting dynamic subtest: smem0-uc [68.063394] Dynamic subtest smem0-uc: SUCCESS (0.017s) [68.064114] Subtest ptrace: SUCCESS (0.075s) [68.148435] [037/130] (919s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [68.234688] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [68.235540] Starting dynamic subtest: pipe-A [69.551594] Dynamic subtest pipe-A: SKIP (1.312s) [69.556575] Starting dynamic subtest: pipe-B [71.618457] Dynamic subtest pipe-B: SKIP (2.069s) [71.622709] Starting dynamic subtest: pipe-C [73.734790] Dynamic subtest pipe-C: SKIP (2.117s) [73.739423] Starting dynamic subtest: pipe-D [75.889641] Dynamic subtest pipe-D: SKIP (2.154s) [75.891186] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (7.654s) [75.949011] [038/130] (911s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [76.049243] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [76.060787] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [76.099243] [039/130] (911s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [76.183418] Starting subtest: yf-tiled-64bpp-rotate-0 [76.184885] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [76.231957] [040/130] (911s left) kms_vblank (wait-forked-busy) [76.311763] Starting subtest: wait-forked-busy [76.313425] Starting dynamic subtest: pipe-A-HDMI-A-1 [77.551785] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.238s) [77.558045] Starting dynamic subtest: pipe-D-HDMI-A-1 [78.789574] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.234s) [78.790361] Subtest wait-forked-busy: SUCCESS (2.478s) [78.893550] [041/130] (908s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [78.992268] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [78.993086] Starting dynamic subtest: pipe-A-valid-mode [79.046154] Dynamic subtest pipe-A-valid-mode: SKIP (0.052s) [79.047681] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.054s) [79.117970] [042/130] (908s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [79.204465] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [80.413551] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (1.209s) [80.508665] [043/130] (907s left) kms_chamelium_frames (vga-frame-dump) [80.653072] Subtest vga-frame-dump: SKIP (0.000s) [80.717817] [044/130] (906s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [80.798011] Starting subtest: short-flip-before-cursor-toggle [81.323892] Subtest short-flip-before-cursor-toggle: SUCCESS (0.525s) [81.407702] [045/130] (906s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [81.489667] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [81.491128] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [81.555459] [046/130] (906s left) kms_big_fb (4-tiled-64bpp-rotate-0) [81.649352] Starting subtest: 4-tiled-64bpp-rotate-0 [81.651084] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s) [81.698130] [047/130] (905s left) kms_prop_blob (invalid-set-prop-any) [81.727187] Starting subtest: invalid-set-prop-any [81.728069] Subtest invalid-set-prop-any: SUCCESS (0.000s) [81.768576] [048/130] (905s left) kms_dirtyfb (psr-dirtyfb-ioctl) [81.857891] Starting subtest: psr-dirtyfb-ioctl [81.859381] Subtest psr-dirtyfb-ioctl: SKIP (0.000s) [81.922598] [049/130] (905s left) syncobj_wait (invalid-signal-one-illegal-handle) [81.960552] Starting subtest: invalid-signal-one-illegal-handle [81.961350] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [82.007496] [050/130] (905s left) kms_force_connector_basic (prune-stale-modes) [82.134074] Starting subtest: prune-stale-modes [82.286583] Subtest prune-stale-modes: SUCCESS (0.151s) [82.415188] [051/130] (905s left) kms_psr (psr-sprite-plane-onoff) [82.495813] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [82.510113] [052/130] (905s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [82.591460] Starting subtest: fbcpsr-rgb101010-draw-blt [82.592914] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s) [82.639937] [053/130] (905s left) kms_lease (setcrtc-implicit-plane) [82.720294] Starting subtest: setcrtc-implicit-plane [82.721043] Starting dynamic subtest: pipe-A-HDMI-A-1 [82.895181] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.174s) [82.901842] Starting dynamic subtest: pipe-B-HDMI-A-1 [83.057363] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.160s) [83.061792] Starting dynamic subtest: pipe-C-HDMI-A-1 [83.206255] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.148s) [83.210790] Starting dynamic subtest: pipe-D-HDMI-A-1 [83.363236] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.155s) [83.364080] Subtest setcrtc-implicit-plane: SUCCESS (0.643s) [83.468435] [054/130] (904s left) kms_big_fb (linear-32bpp-rotate-270) [83.557895] Starting subtest: linear-32bpp-rotate-270 [83.618070] Subtest linear-32bpp-rotate-270: SKIP (0.059s) [83.679114] [055/130] (904s left) gem_create (create-ext-cpu-access-big) [83.820178] Starting subtest: create-ext-cpu-access-big [83.822341] Subtest create-ext-cpu-access-big: SKIP (0.000s) [83.857378] [056/130] (903s left) kms_setmode (invalid-clone-single-crtc) [83.885308] Starting subtest: invalid-clone-single-crtc [83.887771] Subtest invalid-clone-single-crtc: SKIP (0.000s) [83.929578] [057/130] (903s left) gem_exec_schedule (reorder-wide) [84.090174] Starting subtest: reorder-wide [84.091463] Starting dynamic subtest: rcs0 [84.149288] Dynamic subtest rcs0: SUCCESS (0.062s) [84.157507] Starting dynamic subtest: bcs0 [84.210547] Dynamic subtest bcs0: SUCCESS (0.060s) [84.215482] Starting dynamic subtest: vcs0 [84.268278] Dynamic subtest vcs0: SUCCESS (0.057s) [84.276266] Starting dynamic subtest: vcs1 [84.330224] Dynamic subtest vcs1: SUCCESS (0.061s) [84.337977] Starting dynamic subtest: vecs0 [84.390545] Dynamic subtest vecs0: SUCCESS (0.059s) [84.391651] Subtest reorder-wide: SUCCESS (0.305s) [84.539931] [058/130] (903s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [84.635912] Starting subtest: cursorA-vs-flipA-atomic-transitions [95.467463] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.832s) [95.581957] [059/130] (892s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [95.678670] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [95.680153] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [95.740037] [060/130] (892s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [95.829024] Starting subtest: basic-flip-before-cursor-legacy [96.352755] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.523s) [96.453751] [061/130] (891s left) i915_query (query-regions-unallocated) [96.486262] Starting subtest: query-regions-unallocated [96.487010] Subtest query-regions-unallocated: SUCCESS (0.000s) [96.534965] [062/130] (891s left) syncobj_timeline (wait-any-snapshot) [96.569433] Starting subtest: wait-any-snapshot [96.651544] Subtest wait-any-snapshot: SUCCESS (0.082s) [96.702956] [063/130] (891s left) gem_tiling_max_stride [96.810276] [064/130] (891s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt) [96.901966] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt [96.903344] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s) [96.969306] [065/130] (890s left) gem_unref_active_buffers [97.119366] [066/130] (890s left) kms_frontbuffer_tracking (psr-1p-rte) [97.211996] Starting subtest: psr-1p-rte [97.213493] Subtest psr-1p-rte: SKIP (0.000s) [97.285553] [067/130] (890s left) gem_exec_params (cliprects_ptr-dirt) [97.326491] Starting subtest: cliprects_ptr-dirt [97.327308] Subtest cliprects_ptr-dirt: SUCCESS (0.000s) [97.393304] [068/130] (890s left) gem_exec_balancer (parallel-keep-in-fence) [97.629205] Starting subtest: parallel-keep-in-fence [98.394876] Subtest parallel-keep-in-fence: SUCCESS (0.766s) [98.425608] [069/130] (889s left) kms_flip (dpms-off-confusion) [98.509020] Starting subtest: dpms-off-confusion [98.510796] Starting dynamic subtest: A-HDMI-A1 [106.193690] Dynamic subtest A-HDMI-A1: SUCCESS (7.664s) [106.197703] Starting dynamic subtest: B-HDMI-A1 [113.818071] Dynamic subtest B-HDMI-A1: SUCCESS (7.639s) [113.825837] Starting dynamic subtest: C-HDMI-A1 [121.483037] Dynamic subtest C-HDMI-A1: SUCCESS (7.638s) [121.490241] Starting dynamic subtest: D-HDMI-A1 [129.101490] Dynamic subtest D-HDMI-A1: SUCCESS (7.641s) [129.102183] Subtest dpms-off-confusion: SUCCESS (30.594s) [129.242064] [070/130] (858s left) kms_plane_multiple (tiling-none) [129.334168] Starting subtest: tiling-none [129.336099] Starting dynamic subtest: pipe-A-HDMI-A-1 [129.860205] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.525s) [129.864825] Starting dynamic subtest: pipe-B-HDMI-A-1 [130.392951] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.531s) [130.398538] Starting dynamic subtest: pipe-C-HDMI-A-1 [130.941590] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.548s) [130.947412] Starting dynamic subtest: pipe-D-HDMI-A-1 [131.454924] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.512s) [131.455656] Subtest tiling-none: SUCCESS (2.121s) [131.556094] [071/130] (856s left) gem_exec_params (no-vebox) [131.587812] Starting subtest: no-vebox [131.588576] Subtest no-vebox: SUCCESS (0.000s) [131.682505] [072/130] (856s left) i915_pm_rc6_residency (rc6-idle) [131.711850] Starting subtest: rc6-idle [131.715110] Starting dynamic subtest: gt0-rcs0 [143.997249] Dynamic subtest gt0-rcs0: SUCCESS (12.255s) [144.004862] Starting dynamic subtest: gt0-bcs0 [156.204438] Dynamic subtest gt0-bcs0: SUCCESS (12.206s) [156.211867] Starting dynamic subtest: gt0-vcs0 [168.381459] Dynamic subtest gt0-vcs0: SUCCESS (12.202s) [168.389270] Starting dynamic subtest: gt0-vecs0 [180.606505] Dynamic subtest gt0-vecs0: SUCCESS (12.199s) [180.607751] Subtest rc6-idle: SUCCESS (48.866s) [180.659411] [073/130] (807s left) gen7_exec_parse (basic-allowed) [180.699358] Subtest basic-allowed: SKIP (0.000s) [180.716024] [074/130] (807s left) kms_pm_rpm (fences) [181.903880] Starting subtest: fences [186.500493] Subtest fences: SUCCESS (4.588s) [186.544118] [075/130] (801s left) perf_pmu (faulting-read) [186.580879] Starting subtest: faulting-read [186.581579] Starting dynamic subtest: gtt [186.582276] Dynamic subtest gtt: SUCCESS (0.000s) [186.587052] Starting dynamic subtest: wb [186.587899] Dynamic subtest wb: SUCCESS (0.000s) [186.592249] Starting dynamic subtest: wc [186.592962] Dynamic subtest wc: SUCCESS (0.000s) [186.597790] Starting dynamic subtest: uc [186.598490] Dynamic subtest uc: SUCCESS (0.000s) [186.599183] Subtest faulting-read: SUCCESS (0.004s) [186.666707] [076/130] (801s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [186.706218] Starting subtest: yf-tiled-to-vebox-x-tiled [186.707028] Starting dynamic subtest: smem [186.800503] Dynamic subtest smem: SUCCESS (0.094s) [186.801221] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.095s) [186.950714] [077/130] (801s left) kms_cursor_crc (cursor-sliding-128x128) [187.044703] Starting subtest: cursor-sliding-128x128 [187.049848] Starting dynamic subtest: pipe-A-HDMI-A-1 [188.870168] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.821s) [188.897489] Starting dynamic subtest: pipe-D-HDMI-A-1 [190.678499] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.786s) [190.679288] Subtest cursor-sliding-128x128: SUCCESS (3.633s) [190.782995] [078/130] (797s left) sriov_basic (enable-vfs-autoprobe-off) [190.814957] Subtest enable-vfs-autoprobe-off: SKIP (0.000s) [190.835684] [079/130] (797s left) gem_pxp (hw-rejects-pxp-buffer) [193.413301] Starting subtest: hw-rejects-pxp-buffer [193.414352] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s) [193.444216] [080/130] (794s left) kms_chamelium_audio (hdmi-audio) [193.586371] Subtest hdmi-audio: SKIP (0.000s) [193.641818] [081/130] (794s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [193.721987] Starting subtest: ccs-on-another-bo-y-tiled-ccs [193.722833] Starting dynamic subtest: pipe-A-HDMI-A-1 [193.730561] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [193.735841] Starting dynamic subtest: pipe-B-HDMI-A-1 [193.743105] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [193.747348] Starting dynamic subtest: pipe-C-HDMI-A-1 [193.754955] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [193.759048] Starting dynamic subtest: pipe-D-HDMI-A-1 [193.766495] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [193.767845] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s) [193.775542] [082/130] (794s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [193.858990] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [194.400989] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.541s) [194.496948] [083/130] (793s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [194.585858] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [194.587356] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [194.642298] [084/130] (793s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [194.737534] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [194.739149] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [194.789491] [085/130] (793s left) gem_bad_reloc (negative-reloc) [194.817698] Starting subtest: negative-reloc [194.820230] Subtest negative-reloc: SUCCESS (0.000s) [194.904689] [086/130] (793s left) kms_content_protection (dp-mst-lic-type-1) [195.000014] Starting subtest: dp-mst-lic-type-1 [195.001490] Subtest dp-mst-lic-type-1: SKIP (0.000s) [195.048737] [087/130] (793s left) gem_softpin (evict-prime-sanity-check) [195.083462] Starting subtest: evict-prime-sanity-check [195.084274] Starting dynamic subtest: rcs0 [196.212670] Dynamic subtest rcs0: SUCCESS (1.129s) [196.223822] Starting dynamic subtest: bcs0 [197.325808] Dynamic subtest bcs0: SUCCESS (1.112s) [197.333747] Starting dynamic subtest: vcs0 [198.451766] Dynamic subtest vcs0: SUCCESS (1.125s) [198.463414] Starting dynamic subtest: vcs1 [199.581854] Dynamic subtest vcs1: SUCCESS (1.129s) [199.591145] Starting dynamic subtest: vecs0 [200.697987] Dynamic subtest vecs0: SUCCESS (1.115s) [200.705734] Starting dynamic subtest: all [201.827043] Dynamic subtest all: SUCCESS (1.128s) [201.828269] Subtest evict-prime-sanity-check: SUCCESS (6.744s) [201.878783] [088/130] (786s left) gem_lmem_swapping (parallel-multi) [201.919470] Subtest parallel-multi: SKIP (0.000s) [201.941853] [089/130] (786s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [202.042039] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [202.058231] [090/130] (786s left) kms_psr (pr-sprite-plane-move) [202.137405] Subtest pr-sprite-plane-move: SKIP (0.000s) [202.158010] [091/130] (786s left) gem_eio (in-flight-external) [202.192837] Starting subtest: in-flight-external [202.435110] Subtest in-flight-external: SUCCESS (0.241s) [202.529961] [092/130] (785s left) gem_exec_schedule (preempt) [202.565813] Starting subtest: preempt [202.566521] Starting dynamic subtest: rcs0 [202.578418] Dynamic subtest rcs0: SUCCESS (0.012s) [202.583379] Starting dynamic subtest: bcs0 [202.590518] Dynamic subtest bcs0: SUCCESS (0.012s) [202.595619] Starting dynamic subtest: vcs0 [202.602893] Dynamic subtest vcs0: SUCCESS (0.012s) [202.608043] Starting dynamic subtest: vcs1 [202.616085] Dynamic subtest vcs1: SUCCESS (0.013s) [202.621286] Starting dynamic subtest: vecs0 [202.628743] Dynamic subtest vecs0: SUCCESS (0.012s) [202.629464] Subtest preempt: SUCCESS (0.063s) [202.900861] [093/130] (785s left) debugfs_test (read_all_entries_display_on) [202.996172] Starting subtest: read_all_entries_display_on [203.112022] Subtest read_all_entries_display_on: SUCCESS (0.116s) [203.188691] [094/130] (785s left) gem_ctx_isolation (nonpriv) [203.222628] Starting subtest: nonpriv [203.223502] Starting dynamic subtest: rcs0 [203.373894] Dynamic subtest rcs0: SUCCESS (0.143s) [203.378583] Starting dynamic subtest: bcs0 [203.555962] Dynamic subtest bcs0: SUCCESS (0.181s) [203.560693] Starting dynamic subtest: vcs0 [203.740933] Dynamic subtest vcs0: SUCCESS (0.184s) [203.745525] Starting dynamic subtest: vcs1 [203.942429] Dynamic subtest vcs1: SUCCESS (0.201s) [203.947133] Starting dynamic subtest: vecs0 [204.148721] Dynamic subtest vecs0: SUCCESS (0.206s) [204.149578] Subtest nonpriv: SUCCESS (0.918s) [204.292593] [095/130] (784s left) kms_vblank (query-busy) [204.383054] Starting subtest: query-busy [204.383829] Starting dynamic subtest: pipe-A-HDMI-A-1 [205.636066] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.251s) [205.643559] Starting dynamic subtest: pipe-D-HDMI-A-1 [206.866079] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.226s) [206.866966] Subtest query-busy: SUCCESS (2.483s) [206.966476] [096/130] (781s left) kms_addfb_basic (basic-x-tiled-legacy) [206.994555] Starting subtest: basic-x-tiled-legacy [206.995289] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [207.119098] [097/130] (781s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [207.210841] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [207.211598] Starting dynamic subtest: pipe-A-HDMI-A-1 [207.230374] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [207.234785] Starting dynamic subtest: pipe-B-HDMI-A-1 [207.252809] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [207.257078] Starting dynamic subtest: pipe-C-HDMI-A-1 [207.279250] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [207.288680] Starting dynamic subtest: pipe-D-HDMI-A-1 [207.313694] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [207.315813] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.010s) [207.330716] [098/130] (781s left) kms_big_fb (x-tiled-32bpp-rotate-270) [207.419779] Starting subtest: x-tiled-32bpp-rotate-270 [207.484147] Subtest x-tiled-32bpp-rotate-270: SKIP (0.064s) [207.571751] [099/130] (780s left) gem_flink_basic (double-flink) [207.614369] Starting subtest: double-flink [207.615047] Subtest double-flink: SUCCESS (0.000s) [207.669619] [100/130] (780s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [207.761821] Starting subtest: primary-y-tiled-reflect-x-180 [212.677514] Subtest primary-y-tiled-reflect-x-180: SUCCESS (4.915s) [212.860648] [101/130] (775s left) gem_mmap_gtt (basic-read-write-distinct) [212.896390] Starting subtest: basic-read-write-distinct [212.899946] Subtest basic-read-write-distinct: SUCCESS (0.004s) [212.960599] [102/130] (775s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render) [213.057740] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render [213.059265] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [213.107562] [103/130] (775s left) vgem_basic (debugfs) [213.141985] Starting subtest: debugfs [213.142862] Subtest debugfs: SUCCESS (0.000s) [213.170708] [104/130] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [213.263543] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [213.265120] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [213.314051] [105/130] (775s left) kms_flip (wf_vblank-ts-check) [213.397843] Starting subtest: wf_vblank-ts-check [213.402257] Starting dynamic subtest: A-HDMI-A1 [221.228360] Dynamic subtest A-HDMI-A1: SUCCESS (7.807s) [221.232827] Starting dynamic subtest: B-HDMI-A1 [228.997154] Dynamic subtest B-HDMI-A1: SUCCESS (7.781s) [229.001841] Starting dynamic subtest: C-HDMI-A1 [236.801894] Dynamic subtest C-HDMI-A1: SUCCESS (7.780s) [236.806604] Starting dynamic subtest: D-HDMI-A1 [244.570597] Dynamic subtest D-HDMI-A1: SUCCESS (7.792s) [244.571326] Subtest wf_vblank-ts-check: SUCCESS (31.170s) [244.698589] [106/130] (743s left) kms_lease (lease-again) [244.786384] Starting subtest: lease-again [244.787176] Starting dynamic subtest: pipe-A-HDMI-A-1 [244.788031] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [244.794308] Starting dynamic subtest: pipe-B-HDMI-A-1 [244.795095] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [244.800482] Starting dynamic subtest: pipe-C-HDMI-A-1 [244.801265] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [244.805996] Starting dynamic subtest: pipe-D-HDMI-A-1 [244.806780] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [244.807510] Subtest lease-again: SUCCESS (0.010s) [244.834509] [107/130] (743s left) testdisplay [258.771621] [108/130] (729s left) sysfs_preempt_timeout (idempotent) [258.811703] Starting subtest: idempotent [258.813569] Starting dynamic subtest: vecs0 [258.814359] Dynamic subtest vecs0: SUCCESS (0.000s) [258.819294] Starting dynamic subtest: vcs0 [258.820107] Dynamic subtest vcs0: SUCCESS (0.000s) [258.824565] Starting dynamic subtest: bcs0 [258.825308] Dynamic subtest bcs0: SUCCESS (0.000s) [258.829727] Starting dynamic subtest: rcs0 [258.830605] Dynamic subtest rcs0: SUCCESS (0.000s) [258.835143] Starting dynamic subtest: vcs1 [258.835930] Dynamic subtest vcs1: SUCCESS (0.000s) [258.836691] Subtest idempotent: SUCCESS (0.005s) [258.850291] [109/130] (729s left) i915_hangman (detector) [258.880112] Starting subtest: detector [258.880829] Starting dynamic subtest: rcs0 [268.317946] Dynamic subtest rcs0: SUCCESS (9.438s) [268.325232] Starting dynamic subtest: bcs0 [278.304898] Dynamic subtest bcs0: SUCCESS (9.986s) [278.316745] Starting dynamic subtest: vcs0 [288.290951] Dynamic subtest vcs0: SUCCESS (9.985s) [288.298090] Starting dynamic subtest: vcs1 [297.307788] Dynamic subtest vcs1: SUCCESS (9.016s) [297.319874] Starting dynamic subtest: vecs0 [307.301113] Dynamic subtest vecs0: SUCCESS (9.992s) [307.302617] Subtest detector: SUCCESS (48.422s) [307.404907] [110/130] (681s left) gem_exec_whisper (basic-forked) [307.448806] Starting subtest: basic-forked [308.906915] Subtest basic-forked: SUCCESS (1.457s) [309.065077] [111/130] (679s left) kms_atomic_transition (modeset-transition) [309.170106] Starting subtest: modeset-transition [309.170834] Starting dynamic subtest: 1x-outputs [310.342415] Dynamic subtest 1x-outputs: SUCCESS (1.163s) [310.360556] Subtest modeset-transition: SUCCESS (1.190s) [310.481200] [112/130] (678s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [310.573612] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [310.575268] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [310.621897] [113/130] (677s left) gem_exec_async (concurrent-writes) [310.658421] Starting subtest: concurrent-writes [310.659337] Starting dynamic subtest: rcs0 [310.663584] Dynamic subtest rcs0: SUCCESS (0.005s) [310.670170] Starting dynamic subtest: bcs0 [310.671168] Dynamic subtest bcs0: SUCCESS (0.005s) [310.677514] Starting dynamic subtest: vcs0 [310.678277] Dynamic subtest vcs0: SUCCESS (0.004s) [310.684616] Starting dynamic subtest: vcs1 [310.685380] Dynamic subtest vcs1: SUCCESS (0.005s) [310.690176] Starting dynamic subtest: vecs0 [310.690923] Dynamic subtest vecs0: SUCCESS (0.005s) [310.691679] Subtest concurrent-writes: SUCCESS (0.027s) [310.835550] [114/130] (677s left) gem_exec_await (wide-contexts) [310.888825] Starting subtest: wide-contexts [332.934050] Subtest wide-contexts: SUCCESS (22.045s) [333.109535] [115/130] (655s left) syncobj_timeline (reset-multiple-signaled) [333.181974] Starting subtest: reset-multiple-signaled [333.182768] Subtest reset-multiple-signaled: SUCCESS (0.000s) [333.218627] [116/130] (655s left) gem_readwrite (read-write) [333.254475] Starting subtest: read-write [333.257601] Subtest read-write: SUCCESS (0.000s) [333.326047] [117/130] (655s left) gem_exec_reloc (basic-gtt-cpu) [333.365433] Starting subtest: basic-gtt-cpu [333.371173] Subtest basic-gtt-cpu: SUCCESS (0.005s) [333.464120] [118/130] (655s left) api_intel_bb (intel-bb-blit-y) [333.491074] Starting subtest: intel-bb-blit-y [336.708134] Subtest intel-bb-blit-y: SUCCESS (3.209s) [336.765288] [119/130] (651s left) api_intel_bb (bb-with-allocator) [336.792643] Starting subtest: bb-with-allocator [336.795500] Subtest bb-with-allocator: SUCCESS (0.003s) [336.876109] [120/130] (651s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [336.963078] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [336.963851] Starting dynamic subtest: pipe-A-HDMI-A-1 [336.971194] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [336.976286] Starting dynamic subtest: pipe-B-HDMI-A-1 [336.984182] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [336.989412] Starting dynamic subtest: pipe-C-HDMI-A-1 [336.997585] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [337.002412] Starting dynamic subtest: pipe-D-HDMI-A-1 [337.009878] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [337.011329] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.005s) [337.019566] [121/130] (651s left) kms_psr (fbc-pr-sprite-blt) [337.100703] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [337.117975] [122/130] (651s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [337.196963] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [337.198559] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [337.231060] [123/130] (651s left) gem_fence_thrash (bo-write-verify-y) [337.257134] Starting subtest: bo-write-verify-y [338.360564] Subtest bo-write-verify-y: SUCCESS (1.095s) [338.432530] [124/130] (650s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [338.461513] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [338.568256] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s) [338.618920] [125/130] (650s left) gem_partial_pwrite_pread (reads) [338.654776] Starting subtest: reads [339.977771] Subtest reads: SUCCESS (1.323s) [340.068902] [126/130] (648s left) gem_userptr_blits (coherency-unsync) [340.108213] Subtest coherency-unsync: SKIP (0.000s) [340.220259] [127/130] (648s left) gem_set_tiling_vs_pwrite [340.317527] [128/130] (648s left) kms_frontbuffer_tracking (pipe-fbc-rte) [340.412523] Starting subtest: pipe-fbc-rte [340.417030] Subtest pipe-fbc-rte: SKIP (0.000s) [340.473253] [129/130] (648s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [340.565022] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [340.565771] Starting dynamic subtest: pipe-A-valid-mode [341.321972] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.755s) [341.322802] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.757s) [341.448786] [130/130] (647s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [341.482198] Starting subtest: legacy-engines-hostile-preempt [341.482997] Starting dynamic subtest: render [341.586707] Dynamic subtest render: SUCCESS (0.104s) [341.600813] Starting dynamic subtest: bsd1 [341.683704] Dynamic subtest bsd1: SUCCESS (0.095s) [341.698226] Starting dynamic subtest: bsd2 [341.773845] Dynamic subtest bsd2: SUCCESS (0.089s) [341.790647] Starting dynamic subtest: blt [341.861519] Dynamic subtest blt: SUCCESS (0.086s) [341.875889] Starting dynamic subtest: vebox [341.960693] Dynamic subtest vebox: SUCCESS (0.098s) [341.961997] Subtest legacy-engines-hostile-preempt: SUCCESS (0.479s) [342.011542] Closing watchdogs Done.