[32.856972] Initializing watchdogs [32.857019] /dev/watchdog0 [32.861511] [001/130] (960s left) kms_color (legacy-gamma) [32.948823] Starting subtest: legacy-gamma [32.950668] Starting dynamic subtest: pipe-A-HDMI-A-1 [33.275275] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.325s) [33.279666] Starting dynamic subtest: pipe-B-HDMI-A-1 [33.562716] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.285s) [33.566301] Starting dynamic subtest: pipe-C-HDMI-A-1 [33.847019] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.283s) [33.850464] Starting dynamic subtest: pipe-D-HDMI-A-1 [34.136476] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.288s) [34.137385] Subtest legacy-gamma: SUCCESS (1.188s) [34.234881] [002/130] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [34.324393] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [34.325903] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [34.367727] [003/130] (959s left) syncobj_timeline (invalid-signal-zero-handles) [34.402756] Starting subtest: invalid-signal-zero-handles [34.403443] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [34.433188] [004/130] (958s left) gem_exec_reloc (basic-cpu-read-noreloc) [34.472299] Starting subtest: basic-cpu-read-noreloc [34.476874] Subtest basic-cpu-read-noreloc: SUCCESS (0.004s) [34.565430] [005/130] (958s left) kms_properties (invalid-properties-legacy) [34.650796] Starting subtest: invalid-properties-legacy [34.925438] Subtest invalid-properties-legacy: SUCCESS (0.266s) [34.950672] [006/130] (958s left) gem_exec_capture (capture-invisible) [34.982425] Starting subtest: capture-invisible [34.983206] Starting dynamic subtest: smem0 [34.984651] Dynamic subtest smem0: SKIP (0.000s) [34.986140] Subtest capture-invisible: SKIP (0.000s) [35.055946] [007/130] (958s left) kms_chamelium_color (ctm-red-to-blue) [35.146604] Subtest ctm-red-to-blue: SKIP (0.000s) [35.160822] [008/130] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [35.241477] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [35.242985] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [35.295891] [009/130] (958s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [35.384807] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [35.385643] Starting dynamic subtest: pipe-A [35.514294] Dynamic subtest pipe-A: SUCCESS (0.130s) [35.519565] Starting dynamic subtest: pipe-B [35.639580] Dynamic subtest pipe-B: SUCCESS (0.125s) [35.644096] Starting dynamic subtest: pipe-C [35.764331] Dynamic subtest pipe-C: SUCCESS (0.125s) [35.767951] Starting dynamic subtest: pipe-D [35.889692] Dynamic subtest pipe-D: SUCCESS (0.125s) [35.890506] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.505s) [36.030209] [010/130] (957s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [36.120496] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s) [36.136538] [011/130] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [36.216958] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [36.218349] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [36.291522] [012/130] (957s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [36.378705] Starting subtest: 2x-long-flip-vs-cursor-atomic [36.381615] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s) [36.417068] [013/130] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [36.499740] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [36.501061] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [36.556153] [014/130] (956s left) drm_fdinfo (virtual-busy-idle-all) [36.593835] Starting subtest: virtual-busy-idle-all [37.213600] Subtest virtual-busy-idle-all: SUCCESS (0.619s) [37.257880] [015/130] (956s left) kms_psr (psr2-sprite-blt) [37.345661] Subtest psr2-sprite-blt: SKIP (0.000s) [37.361777] [016/130] (956s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [37.444603] Starting subtest: psr-rgb101010-draw-blt [37.446036] Subtest psr-rgb101010-draw-blt: SKIP (0.000s) [37.495777] [017/130] (956s left) kms_cursor_crc (cursor-onscreen-32x10) [37.577972] Starting subtest: cursor-onscreen-32x10 [37.622242] Subtest cursor-onscreen-32x10: SKIP (0.043s) [37.715497] [018/130] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [37.810863] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [37.812356] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [37.851323] [019/130] (955s left) syncobj_wait (single-wait-all-signaled) [37.884936] Starting subtest: single-wait-all-signaled [37.885622] Subtest single-wait-all-signaled: SUCCESS (0.000s) [37.924661] [020/130] (955s left) kms_psr (fbc-psr-sprite-mmap-gtt) [38.012535] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [38.041899] [021/130] (955s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [38.076975] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [38.181120] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s) [38.226198] [022/130] (955s left) kms_writeback (writeback-fb-id) [38.313623] Subtest writeback-fb-id: SKIP (0.000s) [38.328921] [023/130] (955s left) kms_prop_blob (invalid-get-prop) [38.353804] Starting subtest: invalid-get-prop [38.354532] Subtest invalid-get-prop: SUCCESS (0.000s) [38.391275] [024/130] (955s left) gem_exec_schedule (u-submit-early-slice) [38.433126] Starting subtest: u-submit-early-slice [38.434229] Starting dynamic subtest: rcs0 [38.462823] Dynamic subtest rcs0: SUCCESS (0.030s) [38.466638] Starting dynamic subtest: bcs0 [38.491988] Dynamic subtest bcs0: SUCCESS (0.029s) [38.497456] Starting dynamic subtest: vcs0 [38.519501] Dynamic subtest vcs0: SUCCESS (0.028s) [38.524741] Starting dynamic subtest: vcs1 [38.543587] Dynamic subtest vcs1: SUCCESS (0.024s) [38.547741] Starting dynamic subtest: vecs0 [38.571124] Dynamic subtest vecs0: SUCCESS (0.027s) [38.571869] Subtest u-submit-early-slice: SUCCESS (0.138s) [38.835192] [025/130] (954s left) gem_exec_parallel (engines) [38.871769] Starting subtest: engines [38.872519] Starting dynamic subtest: basic [40.237468] Dynamic subtest basic: SUCCESS (1.366s) [40.241977] Starting dynamic subtest: contexts [43.000901] Dynamic subtest contexts: SUCCESS (2.754s) [43.008307] Starting dynamic subtest: fds [45.616714] Dynamic subtest fds: SUCCESS (2.601s) [45.624223] Starting dynamic subtest: userptr [47.054238] Dynamic subtest userptr: SUCCESS (1.421s) [47.055101] Subtest engines: SUCCESS (8.143s) [47.209136] [026/130] (946s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [47.300494] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [47.309328] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [47.370006] [027/130] (946s left) kms_hdr (bpc-switch) [47.460817] Starting subtest: bpc-switch [47.463200] Subtest bpc-switch: SKIP (0.001s) [47.496462] [028/130] (946s left) gem_exec_fence (syncobj-invalid-flags) [47.826830] Starting subtest: syncobj-invalid-flags [47.827534] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [48.095084] [029/130] (945s left) kms_dsc (dsc-with-bpc) [48.184802] Starting subtest: dsc-with-bpc [48.186323] Subtest dsc-with-bpc: SKIP (0.000s) [48.219853] [030/130] (945s left) gem_wait (await) [48.251046] Starting subtest: await [48.251810] Starting dynamic subtest: all-engines [49.278353] Dynamic subtest all-engines: SUCCESS (1.018s) [49.287407] Starting dynamic subtest: rcs0 [50.303430] Dynamic subtest rcs0: SUCCESS (1.017s) [50.310262] Starting dynamic subtest: bcs0 [51.334485] Dynamic subtest bcs0: SUCCESS (1.024s) [51.341487] Starting dynamic subtest: vcs0 [52.356797] Dynamic subtest vcs0: SUCCESS (1.015s) [52.363736] Starting dynamic subtest: vcs1 [53.385345] Dynamic subtest vcs1: SUCCESS (1.025s) [53.392218] Starting dynamic subtest: vecs0 [54.418470] Dynamic subtest vecs0: SUCCESS (1.029s) [54.419504] Subtest await: SUCCESS (6.130s) [54.584833] [031/130] (939s left) kms_addfb_basic (bad-pitch-63) [54.618548] Starting subtest: bad-pitch-63 [54.619231] Subtest bad-pitch-63: SUCCESS (0.000s) [54.750255] [032/130] (939s left) sw_sync (sync_busy_fork_unixsocket) [54.787043] Starting subtest: sync_busy_fork_unixsocket [54.793437] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s) [54.818181] [033/130] (939s left) gem_mmap_wc (coherency) [54.844910] Starting subtest: coherency [54.901848] Subtest coherency: SUCCESS (0.058s) [54.975557] [034/130] (938s left) gem_mmap_offset (close-race) [55.011575] Starting subtest: close-race [75.083121] Subtest close-race: SUCCESS (20.013s) [75.133289] [035/130] (918s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [75.227621] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [75.229091] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s) [75.286116] [036/130] (918s left) gem_mmap_offset (ptrace) [75.321446] Starting subtest: ptrace [75.322131] Starting dynamic subtest: smem0-gtt [75.347073] Dynamic subtest smem0-gtt: SUCCESS (0.025s) [75.351413] Starting dynamic subtest: smem0-wb [75.361542] Dynamic subtest smem0-wb: SUCCESS (0.014s) [75.365680] Starting dynamic subtest: smem0-wc [75.378345] Dynamic subtest smem0-wc: SUCCESS (0.017s) [75.382419] Starting dynamic subtest: smem0-uc [75.395230] Dynamic subtest smem0-uc: SUCCESS (0.017s) [75.395944] Subtest ptrace: SUCCESS (0.075s) [75.480258] [037/130] (918s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [75.567649] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [75.568460] Starting dynamic subtest: pipe-A [76.835062] Dynamic subtest pipe-A: SKIP (1.265s) [76.839648] Starting dynamic subtest: pipe-B [78.792244] Dynamic subtest pipe-B: SKIP (1.957s) [78.796832] Starting dynamic subtest: pipe-C [80.845639] Dynamic subtest pipe-C: SKIP (2.052s) [80.849799] Starting dynamic subtest: pipe-D [82.860882] Dynamic subtest pipe-D: SKIP (2.014s) [82.862611] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (7.289s) [82.942230] [038/130] (911s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [83.038938] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [83.050416] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [83.084332] [039/130] (910s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [83.169690] Starting subtest: yf-tiled-64bpp-rotate-0 [83.171132] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [83.217507] [040/130] (910s left) kms_vblank (wait-forked-busy) [83.295878] Starting subtest: wait-forked-busy [83.297558] Starting dynamic subtest: pipe-A-HDMI-A-1 [84.536908] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.240s) [84.543725] Starting dynamic subtest: pipe-D-HDMI-A-1 [85.775452] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.235s) [85.776212] Subtest wait-forked-busy: SUCCESS (2.480s) [85.868866] [041/130] (908s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [85.965175] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [85.965973] Starting dynamic subtest: pipe-A-valid-mode [86.021359] Dynamic subtest pipe-A-valid-mode: SKIP (0.054s) [86.022810] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.056s) [86.091873] [042/130] (907s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [86.177973] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [87.345910] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (1.168s) [87.447785] [043/130] (906s left) kms_chamelium_frames (vga-frame-dump) [87.578186] Subtest vga-frame-dump: SKIP (0.000s) [87.634688] [044/130] (906s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [87.717733] Starting subtest: short-flip-before-cursor-toggle [88.240318] Subtest short-flip-before-cursor-toggle: SUCCESS (0.523s) [88.328123] [045/130] (905s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [88.415369] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [88.416821] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [88.479594] [046/130] (905s left) kms_big_fb (4-tiled-64bpp-rotate-0) [88.574436] Starting subtest: 4-tiled-64bpp-rotate-0 [88.575983] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s) [88.627857] [047/130] (905s left) kms_prop_blob (invalid-set-prop-any) [88.663145] Starting subtest: invalid-set-prop-any [88.664017] Subtest invalid-set-prop-any: SUCCESS (0.000s) [88.698932] [048/130] (905s left) kms_dirtyfb (psr-dirtyfb-ioctl) [88.781914] Starting subtest: psr-dirtyfb-ioctl [88.783377] Subtest psr-dirtyfb-ioctl: SKIP (0.000s) [88.846153] [049/130] (905s left) syncobj_wait (invalid-signal-one-illegal-handle) [88.881599] Starting subtest: invalid-signal-one-illegal-handle [88.882473] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [88.915703] [050/130] (905s left) kms_force_connector_basic (prune-stale-modes) [89.043576] Starting subtest: prune-stale-modes [89.194423] Subtest prune-stale-modes: SUCCESS (0.152s) [89.322567] [051/130] (904s left) kms_psr (psr-sprite-plane-onoff) [89.407741] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [89.427063] [052/130] (904s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [89.508178] Starting subtest: fbcpsr-rgb101010-draw-blt [89.509779] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s) [89.571218] [053/130] (904s left) kms_lease (setcrtc-implicit-plane) [89.660230] Starting subtest: setcrtc-implicit-plane [89.662205] Starting dynamic subtest: pipe-A-HDMI-A-1 [89.827929] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.166s) [89.833497] Starting dynamic subtest: pipe-B-HDMI-A-1 [89.993263] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.164s) [89.999058] Starting dynamic subtest: pipe-C-HDMI-A-1 [90.155221] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.161s) [90.160814] Starting dynamic subtest: pipe-D-HDMI-A-1 [90.313337] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.157s) [90.314089] Subtest setcrtc-implicit-plane: SUCCESS (0.654s) [90.429299] [054/130] (903s left) kms_big_fb (linear-32bpp-rotate-270) [90.519817] Starting subtest: linear-32bpp-rotate-270 [90.579800] Subtest linear-32bpp-rotate-270: SKIP (0.059s) [90.667625] [055/130] (903s left) gem_create (create-ext-cpu-access-big) [90.809071] Starting subtest: create-ext-cpu-access-big [90.811118] Subtest create-ext-cpu-access-big: SKIP (0.001s) [90.850175] [056/130] (903s left) kms_setmode (invalid-clone-single-crtc) [90.884744] Starting subtest: invalid-clone-single-crtc [90.887274] Subtest invalid-clone-single-crtc: SKIP (0.000s) [90.919302] [057/130] (903s left) gem_exec_schedule (reorder-wide) [91.078971] Starting subtest: reorder-wide [91.079992] Starting dynamic subtest: rcs0 [91.134844] Dynamic subtest rcs0: SUCCESS (0.061s) [91.144519] Starting dynamic subtest: bcs0 [91.197616] Dynamic subtest bcs0: SUCCESS (0.062s) [91.207269] Starting dynamic subtest: vcs0 [91.259032] Dynamic subtest vcs0: SUCCESS (0.060s) [91.268140] Starting dynamic subtest: vcs1 [91.321936] Dynamic subtest vcs1: SUCCESS (0.062s) [91.331185] Starting dynamic subtest: vecs0 [91.383401] Dynamic subtest vecs0: SUCCESS (0.061s) [91.384449] Subtest reorder-wide: SUCCESS (0.310s) [91.536445] [058/130] (902s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [91.628316] Starting subtest: cursorA-vs-flipA-atomic-transitions [102.457616] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.828s) [102.567519] [059/130] (891s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [102.667439] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [102.668919] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [102.730281] [060/130] (891s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [102.822134] Starting subtest: basic-flip-before-cursor-legacy [103.352484] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.531s) [103.441337] [061/130] (890s left) i915_query (query-regions-unallocated) [103.472112] Starting subtest: query-regions-unallocated [103.472776] Subtest query-regions-unallocated: SUCCESS (0.000s) [103.504183] [062/130] (890s left) syncobj_timeline (wait-any-snapshot) [103.530051] Starting subtest: wait-any-snapshot [103.612182] Subtest wait-any-snapshot: SUCCESS (0.082s) [103.654680] [063/130] (890s left) gem_tiling_max_stride [103.766721] [064/130] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt) [103.859462] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt [103.860894] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s) [103.905490] [065/130] (890s left) gem_unref_active_buffers [104.046323] [066/130] (890s left) kms_frontbuffer_tracking (psr-1p-rte) [104.135228] Starting subtest: psr-1p-rte [104.136607] Subtest psr-1p-rte: SKIP (0.000s) [104.181125] [067/130] (890s left) gem_exec_params (cliprects_ptr-dirt) [104.215836] Starting subtest: cliprects_ptr-dirt [104.216649] Subtest cliprects_ptr-dirt: SUCCESS (0.000s) [104.275856] [068/130] (890s left) gem_exec_balancer (parallel-keep-in-fence) [104.500983] Starting subtest: parallel-keep-in-fence [105.263394] Subtest parallel-keep-in-fence: SUCCESS (0.773s) [105.306861] [069/130] (889s left) kms_flip (dpms-off-confusion) [105.395903] Starting subtest: dpms-off-confusion [105.397849] Starting dynamic subtest: A-HDMI-A1 [113.071595] Dynamic subtest A-HDMI-A1: SUCCESS (7.655s) [113.075879] Starting dynamic subtest: B-HDMI-A1 [120.695637] Dynamic subtest B-HDMI-A1: SUCCESS (7.637s) [120.702811] Starting dynamic subtest: C-HDMI-A1 [128.364899] Dynamic subtest C-HDMI-A1: SUCCESS (7.641s) [128.371603] Starting dynamic subtest: D-HDMI-A1 [135.978479] Dynamic subtest D-HDMI-A1: SUCCESS (7.639s) [135.979324] Subtest dpms-off-confusion: SUCCESS (30.582s) [136.115783] [070/130] (858s left) kms_plane_multiple (tiling-none) [136.200242] Starting subtest: tiling-none [136.201095] Starting dynamic subtest: pipe-A-HDMI-A-1 [136.697610] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.497s) [136.702970] Starting dynamic subtest: pipe-B-HDMI-A-1 [137.220623] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.522s) [137.225989] Starting dynamic subtest: pipe-C-HDMI-A-1 [137.758317] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.536s) [137.764765] Starting dynamic subtest: pipe-D-HDMI-A-1 [138.280688] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.521s) [138.281496] Subtest tiling-none: SUCCESS (2.081s) [138.393149] [071/130] (855s left) gem_exec_params (no-vebox) [138.427750] Starting subtest: no-vebox [138.428545] Subtest no-vebox: SUCCESS (0.001s) [138.516247] [072/130] (855s left) i915_pm_rc6_residency (rc6-idle) [138.546141] Starting subtest: rc6-idle [138.548457] Starting dynamic subtest: gt0-rcs0 [150.776421] Dynamic subtest gt0-rcs0: SUCCESS (12.199s) [150.783791] Starting dynamic subtest: gt0-bcs0 [162.976566] Dynamic subtest gt0-bcs0: SUCCESS (12.200s) [162.984464] Starting dynamic subtest: gt0-vcs0 [175.150389] Dynamic subtest gt0-vcs0: SUCCESS (12.199s) [175.159893] Starting dynamic subtest: gt0-vecs0 [187.377474] Dynamic subtest gt0-vecs0: SUCCESS (12.202s) [187.378585] Subtest rc6-idle: SUCCESS (48.805s) [187.434878] [073/130] (806s left) gen7_exec_parse (basic-allowed) [187.473285] Subtest basic-allowed: SKIP (0.000s) [187.490719] [074/130] (806s left) kms_pm_rpm (fences) [188.676882] Starting subtest: fences [193.438674] Subtest fences: SUCCESS (4.753s) [193.490937] [075/130] (800s left) perf_pmu (faulting-read) [193.527314] Starting subtest: faulting-read [193.528072] Starting dynamic subtest: gtt [193.528820] Dynamic subtest gtt: SUCCESS (0.000s) [193.533212] Starting dynamic subtest: wb [193.533884] Dynamic subtest wb: SUCCESS (0.000s) [193.538965] Starting dynamic subtest: wc [193.539782] Dynamic subtest wc: SUCCESS (0.000s) [193.543916] Starting dynamic subtest: uc [193.544653] Dynamic subtest uc: SUCCESS (0.000s) [193.545383] Subtest faulting-read: SUCCESS (0.003s) [193.611222] [076/130] (800s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [193.649317] Starting subtest: yf-tiled-to-vebox-x-tiled [193.650226] Starting dynamic subtest: smem [193.742658] Dynamic subtest smem: SUCCESS (0.093s) [193.743433] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.094s) [193.896170] [077/130] (800s left) kms_cursor_crc (cursor-sliding-128x128) [193.982272] Starting subtest: cursor-sliding-128x128 [193.987020] Starting dynamic subtest: pipe-A-HDMI-A-1 [195.798948] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.813s) [195.826146] Starting dynamic subtest: pipe-D-HDMI-A-1 [197.603361] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.783s) [197.604098] Subtest cursor-sliding-128x128: SUCCESS (3.622s) [197.711025] [078/130] (796s left) sriov_basic (enable-vfs-autoprobe-off) [197.745041] Subtest enable-vfs-autoprobe-off: SKIP (0.000s) [197.760315] [079/130] (796s left) gem_pxp (hw-rejects-pxp-buffer) [200.350281] Starting subtest: hw-rejects-pxp-buffer [200.351284] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s) [200.369777] [080/130] (794s left) kms_chamelium_audio (hdmi-audio) [200.503867] Subtest hdmi-audio: SKIP (0.000s) [200.558896] [081/130] (793s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [200.638103] Starting subtest: ccs-on-another-bo-y-tiled-ccs [200.638956] Starting dynamic subtest: pipe-A-HDMI-A-1 [200.646411] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [200.652060] Starting dynamic subtest: pipe-B-HDMI-A-1 [200.659341] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [200.663438] Starting dynamic subtest: pipe-C-HDMI-A-1 [200.670686] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [200.674917] Starting dynamic subtest: pipe-D-HDMI-A-1 [200.682353] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [200.683782] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s) [200.691319] [082/130] (793s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [200.774996] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [201.292682] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.517s) [201.396081] [083/130] (793s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [201.494133] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [201.495535] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [201.545409] [084/130] (792s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [201.634281] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [201.635601] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [201.703589] [085/130] (792s left) gem_bad_reloc (negative-reloc) [201.739326] Starting subtest: negative-reloc [201.741424] Subtest negative-reloc: SUCCESS (0.000s) [201.830345] [086/130] (792s left) kms_content_protection (dp-mst-lic-type-1) [201.923014] Starting subtest: dp-mst-lic-type-1 [201.924490] Subtest dp-mst-lic-type-1: SKIP (0.000s) [201.986344] [087/130] (792s left) gem_softpin (evict-prime-sanity-check) [202.021700] Starting subtest: evict-prime-sanity-check [202.022434] Starting dynamic subtest: rcs0 [203.141533] Dynamic subtest rcs0: SUCCESS (1.119s) [203.150859] Starting dynamic subtest: bcs0 [204.258453] Dynamic subtest bcs0: SUCCESS (1.116s) [204.266222] Starting dynamic subtest: vcs0 [205.374418] Dynamic subtest vcs0: SUCCESS (1.115s) [205.382141] Starting dynamic subtest: vcs1 [206.495683] Dynamic subtest vcs1: SUCCESS (1.120s) [206.506168] Starting dynamic subtest: vecs0 [207.600441] Dynamic subtest vecs0: SUCCESS (1.104s) [207.608018] Starting dynamic subtest: all [208.719566] Dynamic subtest all: SUCCESS (1.118s) [208.720850] Subtest evict-prime-sanity-check: SUCCESS (6.698s) [208.763697] [088/130] (785s left) gem_lmem_swapping (parallel-multi) [208.799618] Subtest parallel-multi: SKIP (0.000s) [208.816731] [089/130] (785s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [208.902661] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [208.924644] [090/130] (785s left) kms_psr (pr-sprite-plane-move) [209.011357] Subtest pr-sprite-plane-move: SKIP (0.000s) [209.025185] [091/130] (785s left) gem_eio (in-flight-external) [209.056047] Starting subtest: in-flight-external [209.292067] Subtest in-flight-external: SUCCESS (0.235s) [209.388729] [092/130] (785s left) gem_exec_schedule (preempt) [209.428220] Starting subtest: preempt [209.428941] Starting dynamic subtest: rcs0 [209.441800] Dynamic subtest rcs0: SUCCESS (0.013s) [209.446850] Starting dynamic subtest: bcs0 [209.454555] Dynamic subtest bcs0: SUCCESS (0.012s) [209.459685] Starting dynamic subtest: vcs0 [209.467654] Dynamic subtest vcs0: SUCCESS (0.012s) [209.472909] Starting dynamic subtest: vcs1 [209.481145] Dynamic subtest vcs1: SUCCESS (0.013s) [209.486196] Starting dynamic subtest: vecs0 [209.494397] Dynamic subtest vecs0: SUCCESS (0.013s) [209.495112] Subtest preempt: SUCCESS (0.066s) [209.766860] [093/130] (784s left) debugfs_test (read_all_entries_display_on) [209.851749] Starting subtest: read_all_entries_display_on [209.969998] Subtest read_all_entries_display_on: SUCCESS (0.118s) [210.030725] [094/130] (784s left) gem_ctx_isolation (nonpriv) [210.059729] Starting subtest: nonpriv [210.060549] Starting dynamic subtest: rcs0 [210.208991] Dynamic subtest rcs0: SUCCESS (0.140s) [210.213447] Starting dynamic subtest: bcs0 [210.407230] Dynamic subtest bcs0: SUCCESS (0.198s) [210.411963] Starting dynamic subtest: vcs0 [210.588905] Dynamic subtest vcs0: SUCCESS (0.181s) [210.593501] Starting dynamic subtest: vcs1 [210.759275] Dynamic subtest vcs1: SUCCESS (0.170s) [210.763788] Starting dynamic subtest: vecs0 [210.939830] Dynamic subtest vecs0: SUCCESS (0.188s) [210.940597] Subtest nonpriv: SUCCESS (0.880s) [211.093693] [095/130] (783s left) kms_vblank (query-busy) [211.181354] Starting subtest: query-busy [211.182132] Starting dynamic subtest: pipe-A-HDMI-A-1 [212.428120] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.245s) [212.435142] Starting dynamic subtest: pipe-D-HDMI-A-1 [213.659666] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.226s) [213.660527] Subtest query-busy: SUCCESS (2.477s) [213.750531] [096/130] (780s left) kms_addfb_basic (basic-x-tiled-legacy) [213.782135] Starting subtest: basic-x-tiled-legacy [213.782894] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [213.882584] [097/130] (780s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [213.970875] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [213.971663] Starting dynamic subtest: pipe-A-HDMI-A-1 [213.991479] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [213.996313] Starting dynamic subtest: pipe-B-HDMI-A-1 [214.015075] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [214.019693] Starting dynamic subtest: pipe-C-HDMI-A-1 [214.043621] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [214.051964] Starting dynamic subtest: pipe-D-HDMI-A-1 [214.074446] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [214.076146] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.009s) [214.089819] [098/130] (780s left) kms_big_fb (x-tiled-32bpp-rotate-270) [214.179931] Starting subtest: x-tiled-32bpp-rotate-270 [214.242059] Subtest x-tiled-32bpp-rotate-270: SKIP (0.062s) [214.321586] [099/130] (780s left) gem_flink_basic (double-flink) [214.353568] Starting subtest: double-flink [214.354392] Subtest double-flink: SUCCESS (0.000s) [214.412858] [100/130] (780s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [214.499946] Starting subtest: primary-y-tiled-reflect-x-180 [219.073167] Subtest primary-y-tiled-reflect-x-180: SUCCESS (4.573s) [219.250974] [101/130] (775s left) gem_mmap_gtt (basic-read-write-distinct) [219.285904] Starting subtest: basic-read-write-distinct [219.287781] Subtest basic-read-write-distinct: SUCCESS (0.003s) [219.350028] [102/130] (775s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render) [219.443465] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render [219.444995] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [219.506338] [103/130] (775s left) vgem_basic (debugfs) [219.546830] Starting subtest: debugfs [219.547639] Subtest debugfs: SUCCESS (0.000s) [219.575515] [104/130] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [219.660904] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [219.662391] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [219.713548] [105/130] (775s left) kms_flip (wf_vblank-ts-check) [219.798583] Starting subtest: wf_vblank-ts-check [219.800685] Starting dynamic subtest: A-HDMI-A1 [227.614273] Dynamic subtest A-HDMI-A1: SUCCESS (7.795s) [227.618909] Starting dynamic subtest: B-HDMI-A1 [235.378013] Dynamic subtest B-HDMI-A1: SUCCESS (7.780s) [235.384108] Starting dynamic subtest: C-HDMI-A1 [243.186954] Dynamic subtest C-HDMI-A1: SUCCESS (7.780s) [243.194227] Starting dynamic subtest: D-HDMI-A1 [250.943585] Dynamic subtest D-HDMI-A1: SUCCESS (7.778s) [250.944392] Subtest wf_vblank-ts-check: SUCCESS (31.144s) [251.056103] [106/130] (743s left) kms_lease (lease-again) [251.138324] Starting subtest: lease-again [251.139100] Starting dynamic subtest: pipe-A-HDMI-A-1 [251.139851] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [251.147169] Starting dynamic subtest: pipe-B-HDMI-A-1 [251.147976] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [251.153860] Starting dynamic subtest: pipe-C-HDMI-A-1 [251.154591] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [251.160300] Starting dynamic subtest: pipe-D-HDMI-A-1 [251.161012] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [251.161719] Subtest lease-again: SUCCESS (0.009s) [251.186030] [107/130] (743s left) testdisplay [264.897692] [108/130] (729s left) sysfs_preempt_timeout (idempotent) [264.935673] Starting subtest: idempotent [264.936464] Starting dynamic subtest: vecs0 [264.937231] Dynamic subtest vecs0: SUCCESS (0.000s) [264.942048] Starting dynamic subtest: vcs0 [264.942906] Dynamic subtest vcs0: SUCCESS (0.000s) [264.949507] Starting dynamic subtest: bcs0 [264.950314] Dynamic subtest bcs0: SUCCESS (0.000s) [264.957051] Starting dynamic subtest: rcs0 [264.957895] Dynamic subtest rcs0: SUCCESS (0.000s) [264.963738] Starting dynamic subtest: vcs1 [264.964581] Dynamic subtest vcs1: SUCCESS (0.000s) [264.965337] Subtest idempotent: SUCCESS (0.004s) [264.974419] [109/130] (729s left) i915_hangman (detector) [265.006277] Starting subtest: detector [265.007033] Starting dynamic subtest: rcs0 [274.255804] Dynamic subtest rcs0: SUCCESS (9.249s) [274.266756] Starting dynamic subtest: bcs0 [284.322855] Dynamic subtest bcs0: SUCCESS (10.066s) [284.331502] Starting dynamic subtest: vcs0 [294.297795] Dynamic subtest vcs0: SUCCESS (9.974s) [294.308925] Starting dynamic subtest: vcs1 [303.335806] Dynamic subtest vcs1: SUCCESS (9.037s) [303.343673] Starting dynamic subtest: vecs0 [313.298826] Dynamic subtest vecs0: SUCCESS (9.962s) [313.300042] Subtest detector: SUCCESS (48.294s) [313.387690] [110/130] (681s left) gem_exec_whisper (basic-forked) [313.430719] Starting subtest: basic-forked [314.940839] Subtest basic-forked: SUCCESS (1.510s) [315.089989] [111/130] (679s left) kms_atomic_transition (modeset-transition) [315.186133] Starting subtest: modeset-transition [315.186886] Starting dynamic subtest: 1x-outputs [316.352199] Dynamic subtest 1x-outputs: SUCCESS (1.157s) [316.370057] Subtest modeset-transition: SUCCESS (1.184s) [316.481616] [112/130] (678s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [316.575840] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [316.577494] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [316.648169] [113/130] (678s left) gem_exec_async (concurrent-writes) [316.687380] Starting subtest: concurrent-writes [316.688220] Starting dynamic subtest: rcs0 [316.691976] Dynamic subtest rcs0: SUCCESS (0.004s) [316.697753] Starting dynamic subtest: bcs0 [316.698617] Dynamic subtest bcs0: SUCCESS (0.003s) [316.704471] Starting dynamic subtest: vcs0 [316.705229] Dynamic subtest vcs0: SUCCESS (0.004s) [316.710453] Starting dynamic subtest: vcs1 [316.711199] Dynamic subtest vcs1: SUCCESS (0.003s) [316.715849] Starting dynamic subtest: vecs0 [316.716609] Dynamic subtest vecs0: SUCCESS (0.003s) [316.717300] Subtest concurrent-writes: SUCCESS (0.020s) [316.858302] [114/130] (678s left) gem_exec_await (wide-contexts) [316.918663] Starting subtest: wide-contexts [338.958606] Subtest wide-contexts: SUCCESS (22.040s) [339.124477] [115/130] (655s left) syncobj_timeline (reset-multiple-signaled) [339.184597] Starting subtest: reset-multiple-signaled [339.185344] Subtest reset-multiple-signaled: SUCCESS (0.000s) [339.221507] [116/130] (655s left) gem_readwrite (read-write) [339.249831] Starting subtest: read-write [339.252550] Subtest read-write: SUCCESS (0.000s) [339.311826] [117/130] (655s left) gem_exec_reloc (basic-gtt-cpu) [339.348238] Starting subtest: basic-gtt-cpu [339.353671] Subtest basic-gtt-cpu: SUCCESS (0.005s) [339.443746] [118/130] (655s left) api_intel_bb (intel-bb-blit-y) [339.475743] Starting subtest: intel-bb-blit-y [342.708030] Subtest intel-bb-blit-y: SUCCESS (3.199s) [342.752564] [119/130] (652s left) api_intel_bb (bb-with-allocator) [342.780891] Starting subtest: bb-with-allocator [342.781608] Subtest bb-with-allocator: SUCCESS (0.002s) [342.872776] [120/130] (652s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [342.961269] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [342.962058] Starting dynamic subtest: pipe-A-HDMI-A-1 [342.969525] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [342.975814] Starting dynamic subtest: pipe-B-HDMI-A-1 [342.983303] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [342.988300] Starting dynamic subtest: pipe-C-HDMI-A-1 [342.996661] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [343.001852] Starting dynamic subtest: pipe-D-HDMI-A-1 [343.009747] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [343.011597] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.005s) [343.020273] [121/130] (652s left) kms_psr (fbc-pr-sprite-blt) [343.102014] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [343.123228] [122/130] (651s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [343.203299] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [343.204955] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [343.235779] [123/130] (651s left) gem_fence_thrash (bo-write-verify-y) [343.265447] Starting subtest: bo-write-verify-y [344.368551] Subtest bo-write-verify-y: SUCCESS (1.095s) [344.433909] [124/130] (650s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [344.463207] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [344.564710] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s) [344.612588] [125/130] (650s left) gem_partial_pwrite_pread (reads) [344.650047] Starting subtest: reads [345.945090] Subtest reads: SUCCESS (1.295s) [346.029820] [126/130] (649s left) gem_userptr_blits (coherency-unsync) [346.066768] Subtest coherency-unsync: SKIP (0.000s) [346.138310] [127/130] (649s left) gem_set_tiling_vs_pwrite [346.237843] [128/130] (648s left) kms_frontbuffer_tracking (pipe-fbc-rte) [346.332344] Starting subtest: pipe-fbc-rte [346.336337] Subtest pipe-fbc-rte: SKIP (0.000s) [346.394177] [129/130] (648s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [346.484281] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [346.485081] Starting dynamic subtest: pipe-A-valid-mode [347.258023] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.773s) [347.258824] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.774s) [347.371340] [130/130] (647s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [347.406213] Starting subtest: legacy-engines-hostile-preempt [347.407024] Starting dynamic subtest: render [347.503515] Dynamic subtest render: SUCCESS (0.097s) [347.513428] Starting dynamic subtest: bsd1 [347.612668] Dynamic subtest bsd1: SUCCESS (0.107s) [347.625622] Starting dynamic subtest: bsd2 [347.716502] Dynamic subtest bsd2: SUCCESS (0.102s) [347.724420] Starting dynamic subtest: blt [347.806491] Dynamic subtest blt: SUCCESS (0.089s) [347.817468] Starting dynamic subtest: vebox [347.913687] Dynamic subtest vebox: SUCCESS (0.106s) [347.915034] Subtest legacy-engines-hostile-preempt: SUCCESS (0.508s) [347.967059] Closing watchdogs Done.