[57.152344] Initializing watchdogs [57.152388] /dev/watchdog0 [57.165757] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.169963] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.172094] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.175329] [001/133] (960s left) kms_big_fb (x-tiled-16bpp-rotate-270) [57.301513] Starting subtest: x-tiled-16bpp-rotate-270 [57.333989] Subtest x-tiled-16bpp-rotate-270: SKIP (0.032s) [57.439217] [002/133] (960s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [57.528309] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [57.532867] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [57.605910] [003/133] (960s left) gem_ctx_param (invalid-get-ringsize) [57.676896] Starting subtest: invalid-get-ringsize [57.679321] Subtest invalid-get-ringsize: SUCCESS (0.001s) [57.796655] [004/133] (959s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats) [58.169659] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s) [59.005339] [005/133] (958s left) gem_exec_parallel (engines) [59.073434] Starting subtest: engines [59.075928] Starting dynamic subtest: basic [60.888069] Dynamic subtest basic: SUCCESS (1.816s) [60.896806] Starting dynamic subtest: contexts [65.208376] Dynamic subtest contexts: SUCCESS (4.324s) [65.218587] Starting dynamic subtest: fds [69.051205] Dynamic subtest fds: SUCCESS (3.845s) [69.058585] Starting dynamic subtest: userptr [70.871239] Dynamic subtest userptr: SUCCESS (1.820s) [70.873310] Subtest engines: SUCCESS (11.809s) [71.069911] [006/133] (946s left) gem_exec_flush (basic-uc-prw-default) [71.141948] Starting subtest: basic-uc-prw-default [76.610447] Subtest basic-uc-prw-default: SUCCESS (5.471s) [76.813742] [007/133] (941s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [76.913580] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [83.968077] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.059s) [84.077883] [008/133] (933s left) gem_wait (await) [84.149724] Starting subtest: await [84.151938] Starting dynamic subtest: all-engines [85.322996] Dynamic subtest all-engines: SUCCESS (1.175s) [85.338229] Starting dynamic subtest: rcs0 [86.377838] Dynamic subtest rcs0: SUCCESS (1.054s) [86.393539] Starting dynamic subtest: bcs0 [87.435028] Dynamic subtest bcs0: SUCCESS (1.057s) [87.450461] Starting dynamic subtest: vcs0 [88.487353] Dynamic subtest vcs0: SUCCESS (1.051s) [88.503498] Starting dynamic subtest: vcs1 [89.543570] Dynamic subtest vcs1: SUCCESS (1.055s) [89.557095] Starting dynamic subtest: vecs0 [90.599095] Dynamic subtest vecs0: SUCCESS (1.055s) [90.613542] Starting dynamic subtest: ccs0 [91.656317] Dynamic subtest ccs0: SUCCESS (1.055s) [91.658908] Subtest await: SUCCESS (7.511s) [91.853260] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true [91.856094] [009/133] (926s left) gen9_exec_parse (bb-secure) [91.913808] Subtest bb-secure: SKIP (0.000s) [91.991189] [010/133] (926s left) kms_psr (fbc-psr2-no-drrs) [92.091617] Starting subtest: fbc-psr2-no-drrs [92.093812] Starting dynamic subtest: eDP-1 [92.097964] Dynamic subtest eDP-1: SKIP (0.000s) [92.102115] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [92.161756] [011/133] (925s left) prime_busy (hang) [92.211746] Starting subtest: hang [92.214118] Starting dynamic subtest: rcs0 [118.446870] Dynamic subtest rcs0: SUCCESS (26.234s) [118.454829] Starting dynamic subtest: bcs0 [125.538305] Dynamic subtest bcs0: SUCCESS (7.090s) [125.547629] Starting dynamic subtest: vcs0 [132.575628] Dynamic subtest vcs0: SUCCESS (7.039s) [132.586032] Starting dynamic subtest: vcs1 [139.552862] Dynamic subtest vcs1: SUCCESS (6.974s) [139.562324] Starting dynamic subtest: vecs0 [146.590479] Dynamic subtest vecs0: SUCCESS (7.039s) [146.600978] Starting dynamic subtest: ccs0 [160.433334] Dynamic subtest ccs0: SUCCESS (13.837s) [160.435707] Subtest hang: SUCCESS (68.218s) [160.544892] [012/133] (857s left) syncobj_timeline (multi-wait-for-submit-available-signaled) [160.596221] Starting subtest: multi-wait-for-submit-available-signaled [160.598310] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s) [160.685174] [013/133] (857s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [160.785234] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [160.789246] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [160.865948] [014/133] (857s left) gem_exec_balancer (full-late-pulse) [160.931665] Starting subtest: full-late-pulse [165.734053] Subtest full-late-pulse: SUCCESS (4.801s) [166.045741] [015/133] (852s left) kms_scaling_modes (scaling-mode-full) [166.143865] Starting subtest: scaling-mode-full [166.146297] Starting dynamic subtest: pipe-A-eDP-1 [166.242547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.100s) [166.251385] Starting dynamic subtest: pipe-B-eDP-1 [167.450151] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.206s) [167.461650] Starting dynamic subtest: pipe-C-eDP-1 [168.573364] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s) [168.581516] Starting dynamic subtest: pipe-D-eDP-1 [169.714499] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s) [169.716955] Subtest scaling-mode-full: SUCCESS (3.572s) [170.872376] [016/133] (847s left) gem_mmap (basic-small-bo) [170.928663] Subtest basic-small-bo: SKIP (0.000s) [170.986192] [017/133] (847s left) api_intel_allocator (two-level-inception) [171.040963] Starting subtest: two-level-inception [176.441657] Subtest two-level-inception: SUCCESS (5.401s) [176.562520] [018/133] (841s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [176.676332] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [176.678736] Starting dynamic subtest: pipe-A-eDP-1 [176.701592] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [176.711940] Starting dynamic subtest: pipe-B-eDP-1 [176.730990] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [176.738759] Starting dynamic subtest: pipe-C-eDP-1 [176.757687] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [176.765442] Starting dynamic subtest: pipe-D-eDP-1 [176.784720] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [176.786640] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.006s) [178.924867] [019/133] (839s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [178.986511] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [178.991175] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [179.170567] [020/133] (839s left) kms_flip (bo-too-big-interruptible) [179.283950] Starting subtest: bo-too-big-interruptible [179.289315] Starting dynamic subtest: A-eDP1 [180.584824] Dynamic subtest A-eDP1: SUCCESS (1.295s) [180.592689] Starting dynamic subtest: B-eDP1 [181.854651] Dynamic subtest B-eDP1: SUCCESS (1.269s) [181.863670] Starting dynamic subtest: C-eDP1 [183.157066] Dynamic subtest C-eDP1: SUCCESS (1.301s) [183.164845] Starting dynamic subtest: D-eDP1 [184.408526] Dynamic subtest D-eDP1: SUCCESS (1.251s) [184.410983] Subtest bo-too-big-interruptible: SUCCESS (5.127s) [185.605019] [021/133] (832s left) gem_bad_reloc (negative-reloc-bltcopy) [185.677322] Subtest negative-reloc-bltcopy: SKIP (0.000s) [185.745367] [022/133] (832s left) gem_create (create-clear) [185.794825] Starting subtest: create-clear [185.797079] Starting dynamic subtest: smem0 [218.740584] Dynamic subtest smem0: SUCCESS (32.938s) [218.742974] Subtest create-clear: SUCCESS (32.938s) [218.924723] [023/133] (799s left) gem_userptr_blits (map-fixed-invalidate-overlap) [218.994075] Starting subtest: map-fixed-invalidate-overlap [218.998455] Subtest map-fixed-invalidate-overlap: SKIP (0.000s) [219.111286] [024/133] (799s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [219.198811] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [219.202955] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s) [219.271930] [025/133] (799s left) gem_softpin (allocator-nopin) [219.334766] Starting subtest: allocator-nopin [219.412061] Subtest allocator-nopin: SUCCESS (0.077s) [219.537743] [026/133] (799s left) gem_media_fill (media-fill) [219.589644] Subtest media-fill: SKIP (0.000s) [219.711971] [027/133] (798s left) kms_vblank (query-busy-hang) [219.800041] Starting subtest: query-busy-hang [219.802231] Starting dynamic subtest: pipe-A-eDP-1 [246.670733] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.870s) [246.685016] Starting dynamic subtest: pipe-D-eDP-1 [271.641824] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.970s) [271.644428] Subtest query-busy-hang: SUCCESS (51.843s) [272.447664] [028/133] (746s left) sw_sync (alloc_merge_fence) [272.507980] Starting subtest: alloc_merge_fence [272.510039] Subtest alloc_merge_fence: SUCCESS (0.000s) [272.564971] [029/133] (746s left) kms_big_fb (linear-8bpp-rotate-0) [272.670492] Starting subtest: linear-8bpp-rotate-0 [273.861981] Subtest linear-8bpp-rotate-0: SUCCESS (1.192s) [273.987041] [030/133] (744s left) gem_partial_pwrite_pread (reads-display) [274.054332] Subtest reads-display: SKIP (0.000s) [274.128574] [031/133] (744s left) kms_color (gamma) [274.232308] Starting subtest: gamma [274.233937] Starting dynamic subtest: pipe-A-eDP-1 [274.962133] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.729s) [274.971550] Starting dynamic subtest: pipe-B-eDP-1 [276.357539] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.397s) [276.366139] Starting dynamic subtest: pipe-C-eDP-1 [277.734559] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s) [277.744549] Starting dynamic subtest: pipe-D-eDP-1 [279.073515] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s) [279.075717] Subtest gamma: SUCCESS (4.840s) [279.881446] [032/133] (739s left) gem_linear_blits (normal) [280.437031] Starting subtest: normal [284.131614] Subtest normal: SUCCESS (3.693s) [284.338756] [033/133] (734s left) i915_pm_rps (thresholds-idle) [284.431157] Starting subtest: thresholds-idle [284.435559] Subtest thresholds-idle: SKIP (0.001s) [284.539168] [034/133] (734s left) gem_mmap_wc (read-write-distinct) [284.599905] Subtest read-write-distinct: SKIP (0.000s) [284.658598] [035/133] (734s left) kms_lease (setcrtc-implicit-plane) [284.766800] Starting subtest: setcrtc-implicit-plane [284.769120] Starting dynamic subtest: pipe-A-eDP-1 [285.243800] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.476s) [285.253717] Starting dynamic subtest: pipe-B-eDP-1 [286.409864] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.166s) [286.418261] Starting dynamic subtest: pipe-C-eDP-1 [287.547419] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.136s) [287.558633] Starting dynamic subtest: pipe-D-eDP-1 [288.671689] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s) [288.673873] Subtest setcrtc-implicit-plane: SUCCESS (3.905s) [289.524261] [036/133] (729s left) gem_ctx_persistence (heartbeat-close) [289.584708] Starting subtest: heartbeat-close [289.589185] Subtest heartbeat-close: SKIP (0.000s) [289.686494] [037/133] (729s left) kms_psr (pr-cursor-plane-onoff) [289.787108] Starting subtest: pr-cursor-plane-onoff [289.791160] Subtest pr-cursor-plane-onoff: SKIP (0.000s) [289.858953] [038/133] (729s left) gem_exec_balancer (parallel-ordering) [290.115577] Starting subtest: parallel-ordering [291.064578] Subtest parallel-ordering: SUCCESS (0.949s) [291.200993] [039/133] (727s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [291.292850] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [291.297321] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [291.385702] [040/133] (727s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [291.482844] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [291.487095] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [291.588734] [041/133] (727s left) gem_ppgtt (flink-and-close-vma-leak) [291.653541] Starting subtest: flink-and-close-vma-leak [291.692581] Subtest flink-and-close-vma-leak: SUCCESS (0.041s) [291.817450] [042/133] (727s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [291.906899] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [291.909220] Starting dynamic subtest: pipe-A-eDP-1 [291.932904] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [291.944200] Starting dynamic subtest: pipe-B-eDP-1 [291.965418] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [291.973401] Starting dynamic subtest: pipe-C-eDP-1 [291.994868] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [292.002965] Starting dynamic subtest: pipe-D-eDP-1 [292.024961] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [292.029287] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s) [294.183835] [043/133] (725s left) gem_workarounds (basic-read-context) [294.256626] Starting subtest: basic-read-context [294.272683] Subtest basic-read-context: SUCCESS (0.016s) [294.396109] [044/133] (724s left) kms_vrr (negative-basic) [294.492155] Starting subtest: negative-basic [294.498773] Starting dynamic subtest: pipe-A-eDP-1 [299.910525] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.410s) [300.189218] Subtest negative-basic: SUCCESS (5.697s) [301.000100] [045/133] (718s left) gem_mmap (basic) [301.060187] Subtest basic: SKIP (0.000s) [301.118640] [046/133] (718s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [301.215893] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [301.218094] Starting dynamic subtest: pipe-A-eDP-1 [301.239477] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [301.248132] Starting dynamic subtest: pipe-B-eDP-1 [301.269192] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [301.277698] Starting dynamic subtest: pipe-C-eDP-1 [301.298661] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [301.306877] Starting dynamic subtest: pipe-D-eDP-1 [301.328726] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [301.332752] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.003s) [303.463818] [047/133] (716s left) kms_plane (plane-panning-bottom-right) [303.572990] Starting subtest: plane-panning-bottom-right [303.575322] Starting dynamic subtest: pipe-A [305.237504] Dynamic subtest pipe-A: SUCCESS (1.663s) [305.246202] Starting dynamic subtest: pipe-B [307.487746] Dynamic subtest pipe-B: SUCCESS (2.251s) [307.490173] Subtest plane-panning-bottom-right: SUCCESS (3.916s) [308.304343] [048/133] (711s left) kms_hdr (bpc-switch-suspend) [308.406263] Starting subtest: bpc-switch-suspend [309.471073] Starting dynamic subtest: pipe-A-eDP-1 [329.227915] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.425s) [329.230822] Subtest bpc-switch-suspend: SUCCESS (6.493s) [329.356097] [049/133] (690s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [329.483665] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [336.898442] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.470s) [337.021921] [050/133] (682s left) kms_cursor_crc (cursor-onscreen-128x128) [337.228201] Starting subtest: cursor-onscreen-128x128 [337.234376] Starting dynamic subtest: pipe-A-eDP-1 [339.335682] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.110s) [339.369058] Starting dynamic subtest: pipe-D-eDP-1 [342.110236] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.757s) [342.113254] Subtest cursor-onscreen-128x128: SUCCESS (4.897s) [342.899321] [051/133] (676s left) syncobj_timeline (wait-for-submit-delayed-submit) [342.961950] Starting subtest: wait-for-submit-delayed-submit [343.068610] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s) [343.172840] [052/133] (676s left) kms_draw_crc (draw-method-pwrite) [343.264636] Starting subtest: draw-method-pwrite [343.267154] Starting dynamic subtest: xrgb8888-untiled [343.852975] Dynamic subtest xrgb8888-untiled: SUCCESS (0.591s) [343.872921] Starting dynamic subtest: rgb565-untiled [344.296532] Dynamic subtest rgb565-untiled: SUCCESS (0.443s) [344.317939] Starting dynamic subtest: xrgb2101010-untiled [344.839714] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s) [344.849913] Starting dynamic subtest: xbgr16161616f-untiled [345.615965] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.777s) [345.625939] Starting dynamic subtest: xrgb8888-xtiled [347.412928] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.798s) [347.422843] Starting dynamic subtest: rgb565-xtiled [348.500706] Dynamic subtest rgb565-xtiled: SUCCESS (1.088s) [348.510201] Starting dynamic subtest: xrgb2101010-xtiled [350.298788] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.799s) [350.310770] Starting dynamic subtest: xbgr16161616f-xtiled [353.674528] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.377s) [353.683947] Starting dynamic subtest: xrgb8888-4tiled [354.794188] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.120s) [354.803741] Starting dynamic subtest: rgb565-4tiled [355.371430] Dynamic subtest rgb565-4tiled: SUCCESS (0.576s) [355.380860] Starting dynamic subtest: xrgb2101010-4tiled [356.529206] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.154s) [356.538386] Starting dynamic subtest: xbgr16161616f-4tiled [359.558721] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.033s) [359.561444] Subtest draw-method-pwrite: SUCCESS (16.314s) [359.655505] [053/133] (660s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [359.761804] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [359.766214] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [359.858481] [054/133] (659s left) perf_pmu (init-busy) [359.900904] Starting subtest: init-busy [359.903684] Starting dynamic subtest: rcs0 [359.906336] Dynamic subtest rcs0: SUCCESS (0.001s) [359.917931] Starting dynamic subtest: bcs0 [359.920719] Dynamic subtest bcs0: SUCCESS (0.001s) [359.929967] Starting dynamic subtest: vcs0 [359.932695] Dynamic subtest vcs0: SUCCESS (0.001s) [359.941939] Starting dynamic subtest: vcs1 [359.944640] Dynamic subtest vcs1: SUCCESS (0.001s) [359.953780] Starting dynamic subtest: vecs0 [359.956708] Dynamic subtest vecs0: SUCCESS (0.001s) [359.965791] Starting dynamic subtest: ccs0 [359.968203] Dynamic subtest ccs0: SUCCESS (0.000s) [359.970979] Subtest init-busy: SUCCESS (0.013s) [360.024091] [055/133] (659s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [360.129937] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [360.135470] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [360.232342] [056/133] (659s left) syncobj_wait (single-wait-all-for-submit-submitted) [360.291694] Starting subtest: single-wait-all-for-submit-submitted [360.398695] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.105s) [360.485200] [057/133] (659s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [360.576167] Starting subtest: nonblocking-crc-frame-sequence [360.578860] Starting dynamic subtest: pipe-A-eDP-1 [361.371848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s) [361.382643] Starting dynamic subtest: pipe-B-eDP-1 [362.808653] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s) [362.819977] Starting dynamic subtest: pipe-C-eDP-1 [364.188590] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s) [364.199244] Starting dynamic subtest: pipe-D-eDP-1 [365.552503] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.364s) [365.555594] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.974s) [366.435616] [058/133] (653s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [366.548710] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [367.575745] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.027s) [367.701794] [059/133] (652s left) kms_cdclk (mode-transition-all-outputs) [367.785658] Starting subtest: mode-transition-all-outputs [368.077758] Subtest mode-transition-all-outputs: SKIP (0.288s) [368.869323] [060/133] (651s left) kms_vblank (ts-continuation-idle-hang) [368.960193] Starting subtest: ts-continuation-idle-hang [368.962854] Starting dynamic subtest: pipe-A-eDP-1 [395.045746] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.089s) [395.061460] Starting dynamic subtest: pipe-D-eDP-1 [410.013261] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.971s) [410.016532] Subtest ts-continuation-idle-hang: SUCCESS (41.064s) [410.856751] [061/133] (609s left) gem_mmap_offset (bad-extensions) [410.919444] Starting subtest: bad-extensions [410.922794] Subtest bad-extensions: SUCCESS (0.000s) [411.020475] [062/133] (609s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc) [411.120787] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc [418.169574] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.054s) [418.294510] [063/133] (601s left) kms_properties (colorop-properties-legacy) [418.402650] Starting subtest: colorop-properties-legacy [418.404802] Starting dynamic subtest: pipe-A-eDP-1 [418.744155] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.343s) [418.755295] Starting dynamic subtest: pipe-B-eDP-1 [419.801719] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.053s) [419.811785] Starting dynamic subtest: pipe-C-eDP-1 [420.840946] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.040s) [420.852866] Starting dynamic subtest: pipe-D-eDP-1 [421.885237] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.041s) [421.887738] Subtest colorop-properties-legacy: SUCCESS (3.483s) [422.703966] [064/133] (597s left) kms_chamelium_hpd (vga-hpd) [423.103772] Subtest vga-hpd: SKIP (0.000s) [423.889810] [065/133] (596s left) syncobj_wait (invalid-single-wait-unsubmitted) [423.946461] Starting subtest: invalid-single-wait-unsubmitted [423.949222] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [424.045084] [066/133] (596s left) kms_psr (fbc-psr-sprite-render) [424.134651] Starting subtest: fbc-psr-sprite-render [424.136932] Starting dynamic subtest: eDP-1 [424.141697] Dynamic subtest eDP-1: SKIP (0.000s) [424.146740] Subtest fbc-psr-sprite-render: SKIP (0.001s) [424.223413] [067/133] (596s left) kms_plane (pixel-format-linear-modifier-source-clamping) [424.311900] Starting subtest: pixel-format-linear-modifier-source-clamping [424.337768] Starting dynamic subtest: pipe-A-plane-0 [428.105953] Dynamic subtest pipe-A-plane-0: SUCCESS (3.766s) [428.115313] Starting dynamic subtest: pipe-A-plane-3 [429.763473] Dynamic subtest pipe-A-plane-3: SUCCESS (1.655s) [430.898370] Starting dynamic subtest: pipe-B-plane-0 [434.592687] Dynamic subtest pipe-B-plane-0: SUCCESS (3.700s) [434.605246] Starting dynamic subtest: pipe-B-plane-3 [436.393476] Dynamic subtest pipe-B-plane-3: SUCCESS (1.798s) [436.715716] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.396s) [437.589321] [068/133] (582s left) kms_addfb_basic (bad-pitch-999) [437.655729] Starting subtest: bad-pitch-999 [437.658390] Subtest bad-pitch-999: SUCCESS (0.000s) [437.789443] [069/133] (582s left) syncobj_basic (create-signaled) [437.853856] Starting subtest: create-signaled [437.856946] Subtest create-signaled: SUCCESS (0.000s) [437.948224] [070/133] (582s left) kms_big_fb (y-tiled-64bpp-rotate-270) [438.044722] Starting subtest: y-tiled-64bpp-rotate-270 [438.048962] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [438.137539] [071/133] (582s left) i915_drm_fdinfo (most-busy-check-all) [438.181353] Starting subtest: most-busy-check-all [438.183747] Starting dynamic subtest: rcs0 [438.188680] Dynamic subtest rcs0: SKIP (0.004s) [438.201412] Starting dynamic subtest: bcs0 [438.206651] Dynamic subtest bcs0: SKIP (0.000s) [438.216058] Starting dynamic subtest: vcs0 [438.221306] Dynamic subtest vcs0: SKIP (0.000s) [438.230848] Starting dynamic subtest: vcs1 [438.235488] Dynamic subtest vcs1: SKIP (0.000s) [438.245032] Starting dynamic subtest: vecs0 [438.250119] Dynamic subtest vecs0: SKIP (0.000s) [438.259792] Starting dynamic subtest: ccs0 [438.264823] Dynamic subtest ccs0: SKIP (0.000s) [438.270015] Subtest most-busy-check-all: SKIP (0.008s) [438.311476] [072/133] (582s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [438.454348] Starting subtest: cursorB-vs-flipA-legacy [438.459464] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s) [438.598278] [073/133] (582s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite) [438.691702] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite [443.126457] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.435s) [444.286212] [074/133] (576s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [444.404725] Starting subtest: basic-flip-after-cursor-legacy [445.337728] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.932s) [446.205685] [075/133] (574s left) gem_lmem_swapping (heavy-verify-multi) [446.249772] Subtest heavy-verify-multi: SKIP (0.000s) [446.293964] [076/133] (574s left) kms_psr (psr-cursor-mmap-cpu) [446.395810] Starting subtest: psr-cursor-mmap-cpu [446.398722] Starting dynamic subtest: eDP-1 [448.110814] Dynamic subtest eDP-1: SUCCESS (1.714s) [448.113181] Subtest psr-cursor-mmap-cpu: SUCCESS (1.715s) [448.968123] [077/133] (571s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [449.065721] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [449.070553] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [449.154264] [078/133] (571s left) kms_flip (wf_vblank-ts-check-interruptible) [449.253223] Starting subtest: wf_vblank-ts-check-interruptible [449.255624] Starting dynamic subtest: A-eDP1 [458.113758] Dynamic subtest A-eDP1: SUCCESS (8.857s) [458.128961] Starting dynamic subtest: B-eDP1 [467.035948] Dynamic subtest B-eDP1: SUCCESS (8.920s) [467.046268] Starting dynamic subtest: C-eDP1 [475.956186] Dynamic subtest C-eDP1: SUCCESS (8.919s) [475.966034] Starting dynamic subtest: D-eDP1 [484.882221] Dynamic subtest D-eDP1: SUCCESS (8.925s) [484.888741] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.633s) [486.117690] [079/133] (534s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [486.214216] Starting subtest: primary-y-tiled-reflect-x-270 [486.219742] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [486.289360] [080/133] (534s left) kms_big_fb (4-tiled-8bpp-rotate-270) [486.387188] Starting subtest: 4-tiled-8bpp-rotate-270 [486.407859] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.022s) [486.512433] [081/133] (534s left) gem_exec_fence (syncobj-export) [486.978595] Starting subtest: syncobj-export [486.980673] Subtest syncobj-export: SUCCESS (0.006s) [488.282516] [082/133] (532s left) kms_flip (basic-flip-vs-modeset) [488.378854] Starting subtest: basic-flip-vs-modeset [488.381735] Starting dynamic subtest: A-eDP1 [491.024137] Dynamic subtest A-eDP1: SUCCESS (2.648s) [491.033795] Starting dynamic subtest: B-eDP1 [493.189785] Dynamic subtest B-eDP1: SUCCESS (2.165s) [493.200637] Starting dynamic subtest: C-eDP1 [495.336790] Dynamic subtest C-eDP1: SUCCESS (2.143s) [495.347694] Starting dynamic subtest: D-eDP1 [497.404909] Dynamic subtest D-eDP1: SUCCESS (2.070s) [497.407727] Subtest basic-flip-vs-modeset: SUCCESS (9.034s) [498.208646] [083/133] (522s left) gem_set_tiling_vs_blt (tiled-to-untiled) [498.261759] Subtest tiled-to-untiled: SKIP (0.000s) [498.326274] [084/133] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt) [498.423649] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt [498.428703] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [498.524300] [085/133] (522s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [498.622950] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [498.627300] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [498.720202] [086/133] (522s left) kms_cursor_crc (cursor-rapid-movement-256x256) [498.969930] Starting subtest: cursor-rapid-movement-256x256 [498.972777] Starting dynamic subtest: pipe-A-eDP-1 [499.503937] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s) [499.536559] Starting dynamic subtest: pipe-D-eDP-1 [500.704099] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.180s) [500.706963] Subtest cursor-rapid-movement-256x256: SUCCESS (1.735s) [501.564805] [087/133] (519s left) kms_pm_rpm (drm-resources-equal) [503.402280] Starting subtest: drm-resources-equal [508.422182] Subtest drm-resources-equal: SUCCESS (5.018s) [508.526691] [088/133] (512s left) kms_flip (dpms-vs-vblank-race-interruptible) [508.627771] Starting subtest: dpms-vs-vblank-race-interruptible [508.630695] Starting dynamic subtest: A-eDP1 [512.507950] Dynamic subtest A-eDP1: SUCCESS (3.878s) [512.519758] Starting dynamic subtest: B-eDP1 [517.126899] Dynamic subtest B-eDP1: SUCCESS (4.621s) [517.136413] Starting dynamic subtest: C-eDP1 [521.745415] Dynamic subtest C-eDP1: SUCCESS (4.616s) [521.758724] Starting dynamic subtest: D-eDP1 [525.274785] Dynamic subtest D-eDP1: SUCCESS (3.530s) [525.277823] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (16.653s) [526.146728] [089/133] (495s left) kms_cursor_legacy (torture-move) [526.276759] Starting subtest: torture-move [526.278965] Starting dynamic subtest: pipe-A [532.702090] Dynamic subtest pipe-A: SUCCESS (6.411s) [532.713995] Starting dynamic subtest: pipe-B [539.583168] Dynamic subtest pipe-B: SUCCESS (6.897s) [539.595522] Starting dynamic subtest: pipe-C [545.814179] Dynamic subtest pipe-C: SUCCESS (6.231s) [545.839492] Starting dynamic subtest: pipe-D [553.314770] Dynamic subtest pipe-D: SUCCESS (7.498s) [553.327146] Starting dynamic subtest: all-pipes [560.632280] Dynamic subtest all-pipes: SUCCESS (7.314s) [560.634813] Subtest torture-move: SUCCESS (34.360s) [560.792753] [090/133] (460s left) gem_exec_schedule (pi-userfault) [560.976933] Starting subtest: pi-userfault [560.979216] Starting dynamic subtest: rcs0 [560.986433] Dynamic subtest rcs0: SUCCESS (0.013s) [560.996471] Starting dynamic subtest: bcs0 [560.998744] Dynamic subtest bcs0: SUCCESS (0.011s) [561.007927] Starting dynamic subtest: vcs0 [561.010628] Dynamic subtest vcs0: SUCCESS (0.010s) [561.019648] Starting dynamic subtest: vcs1 [561.022074] Dynamic subtest vcs1: SUCCESS (0.009s) [561.030977] Starting dynamic subtest: vecs0 [561.033081] Dynamic subtest vecs0: SUCCESS (0.009s) [561.042185] Starting dynamic subtest: ccs0 [561.044665] Dynamic subtest ccs0: SUCCESS (0.008s) [561.046919] Subtest pi-userfault: SUCCESS (0.065s) [561.234438] [091/133] (460s left) kms_cursor_edge_walk (64x64-right-edge) [561.346392] Starting subtest: 64x64-right-edge [561.348590] Starting dynamic subtest: pipe-A-eDP-1 [564.811203] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.463s) [564.822344] Starting dynamic subtest: pipe-D-eDP-1 [567.948166] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s) [567.950927] Subtest 64x64-right-edge: SUCCESS (6.600s) [568.745223] [092/133] (452s left) kms_busy (extended-pageflip-hang-oldfb) [568.833339] Starting subtest: extended-pageflip-hang-oldfb [568.835573] Starting dynamic subtest: pipe-A [569.226045] Dynamic subtest pipe-A: SUCCESS (0.392s) [569.235932] Starting dynamic subtest: pipe-D [570.369106] Dynamic subtest pipe-D: SUCCESS (1.141s) [570.371596] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.537s) [571.212633] [093/133] (450s left) gem_mmap_wc (write-wc-read-gtt) [571.272737] Subtest write-wc-read-gtt: SKIP (0.000s) [571.329984] [094/133] (450s left) sw_sync (alloc_fence_invalid_timeline) [571.365809] Starting subtest: alloc_fence_invalid_timeline [571.368885] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [571.414066] [095/133] (450s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [571.477791] Starting subtest: multi-wait-all-available-submitted-signaled [571.480715] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [571.571474] [096/133] (450s left) gem_exec_reloc (basic-range) [571.620136] Subtest basic-range: SKIP (0.000s) [571.685088] [097/133] (449s left) i915_pm_rpm (gem-evict-pwrite) [573.410222] Starting subtest: gem-evict-pwrite [573.415813] Subtest gem-evict-pwrite: SKIP (0.000s) [573.957154] [098/133] (447s left) i915_module_load (reload-no-display) [573.997586] Starting subtest: reload-no-display [579.224963] Subtest reload-no-display: SUCCESS (5.227s) [579.254383] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [579.255125] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [579.258777] [099/133] (442s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [581.765200] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [586.558501] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.797s) [587.731366] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [587.732528] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)] new: kernel.kmod_is_loaded.i915: true [587.736422] [100/133] (434s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [587.878742] Starting subtest: verify-pxp-execution-after-suspend-resume [594.897258] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.018s) [595.034811] [101/133] (426s left) drm_mm (drm_mm) [595.087533] Starting subtest: drm_mm [595.096907] Starting dynamic subtest: drm_test_mm_init [595.183717] Dynamic subtest drm_test_mm_init: SUCCESS (0.086s) [595.200734] Starting dynamic subtest: drm_test_mm_debug [595.279688] Dynamic subtest drm_test_mm_debug: SUCCESS (0.095s) [595.290567] Starting dynamic subtest: drm_test_mm_align32 [595.371606] Dynamic subtest drm_test_mm_align32: SUCCESS (0.091s) [595.380847] Starting dynamic subtest: drm_test_mm_align64 [595.496657] Dynamic subtest drm_test_mm_align64: SUCCESS (0.124s) [595.507768] Starting dynamic subtest: drm_test_mm_lowest [595.597592] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.097s) [595.606260] Starting dynamic subtest: drm_test_mm_highest [595.690576] Dynamic subtest drm_test_mm_highest: SUCCESS (0.094s) [595.693298] Subtest drm_mm: SUCCESS (0.603s) [595.821904] [102/133] (426s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [595.916691] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [595.919324] Starting dynamic subtest: pipe-A [595.938672] Dynamic subtest pipe-A: SKIP (0.017s) [595.948883] Starting dynamic subtest: pipe-B [595.975908] Dynamic subtest pipe-B: SKIP (0.035s) [595.985441] Starting dynamic subtest: pipe-C [596.010337] Dynamic subtest pipe-C: SKIP (0.035s) [596.021577] Starting dynamic subtest: pipe-D [596.045082] Dynamic subtest pipe-D: SKIP (0.035s) [596.049520] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.125s) [596.148156] [103/133] (425s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render) [596.251758] Starting subtest: fbcpsr-rgb565-draw-render [603.298979] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.051s) [603.435025] [104/133] (418s left) vgem_basic (dmabuf-export) [603.486805] Starting subtest: dmabuf-export [603.506199] Subtest dmabuf-export: SUCCESS (0.019s) [603.604456] [105/133] (418s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [603.671402] Starting subtest: invalid-bsd2-flag-on-vebox [603.673931] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [603.765345] [106/133] (418s left) syncobj_eventfd (timeline-wait-signaled) [603.816715] Starting subtest: timeline-wait-signaled [603.819440] Subtest timeline-wait-signaled: SUCCESS (0.000s) [603.935527] [107/133] (418s left) gem_exec_alignment (forked) [603.987623] Starting subtest: forked [641.759699] Subtest forked: SUCCESS (37.774s) [642.074843] [108/133] (380s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [642.193164] Starting subtest: etime-multi-wait-available-unsubmitted [642.301604] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s) [642.380841] [109/133] (379s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic) [642.479769] Starting subtest: async-flip-with-page-flip-events-linear-atomic [642.863666] Starting dynamic subtest: pipe-A-eDP-1 [645.601261] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.737s) [645.987898] Starting dynamic subtest: pipe-B-eDP-1 [648.730439] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.749s) [649.117941] Starting dynamic subtest: pipe-C-eDP-1 [651.851781] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.754s) [652.228781] Starting dynamic subtest: pipe-D-eDP-1 [654.985359] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s) [654.988279] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.507s) [656.174782] [110/133] (365s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [656.268946] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [656.271481] Starting dynamic subtest: A-eDP1 [659.919505] Dynamic subtest A-eDP1: SUCCESS (3.648s) [659.930671] Starting dynamic subtest: B-eDP1 [663.108066] Dynamic subtest B-eDP1: SUCCESS (3.189s) [663.118943] Starting dynamic subtest: C-eDP1 [666.339445] Dynamic subtest C-eDP1: SUCCESS (3.229s) [666.351301] Starting dynamic subtest: D-eDP1 [669.438176] Dynamic subtest D-eDP1: SUCCESS (3.098s) [669.440933] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.171s) [670.296142] [111/133] (351s left) kms_rmfb (close-fd) [670.405946] Starting subtest: close-fd [670.408254] Starting dynamic subtest: pipe-A-eDP-1 [670.514150] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s) [670.523612] Starting dynamic subtest: pipe-B-eDP-1 [671.723823] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s) [671.737758] Starting dynamic subtest: pipe-C-eDP-1 [672.862353] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.136s) [672.881156] Starting dynamic subtest: pipe-D-eDP-1 [674.014727] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.152s) [674.017608] Subtest close-fd: SUCCESS (3.611s) [675.231506] [112/133] (347s left) gem_exec_schedule (u-submit-late-slice) [675.299498] Starting subtest: u-submit-late-slice [675.301476] Starting dynamic subtest: rcs0 [675.331537] Dynamic subtest rcs0: SUCCESS (0.039s) [675.342681] Starting dynamic subtest: bcs0 [675.363474] Dynamic subtest bcs0: SUCCESS (0.031s) [675.372439] Starting dynamic subtest: vcs0 [675.395466] Dynamic subtest vcs0: SUCCESS (0.031s) [675.404414] Starting dynamic subtest: vcs1 [675.423454] Dynamic subtest vcs1: SUCCESS (0.027s) [675.432774] Starting dynamic subtest: vecs0 [675.459587] Dynamic subtest vecs0: SUCCESS (0.036s) [675.468915] Starting dynamic subtest: ccs0 [675.494965] Dynamic subtest ccs0: SUCCESS (0.034s) [675.497772] Subtest u-submit-late-slice: SUCCESS (0.203s) [677.370104] [113/133] (344s left) gem_eio (wait-immediate) [677.593068] Starting subtest: wait-immediate [677.961670] Subtest wait-immediate: SUCCESS (0.368s) [678.108479] [114/133] (344s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [678.209922] Starting subtest: yf-tiled-64bpp-rotate-180 [678.215167] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [678.308347] [115/133] (344s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [678.414381] Starting subtest: pr-overlay-primary-update-sf-dmg-area [678.418364] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [678.493187] [116/133] (343s left) kms_invalid_mode (uint-max-clock) [678.584893] Starting subtest: uint-max-clock [678.586996] Starting dynamic subtest: pipe-A-eDP-1 [678.884721] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s) [678.894335] Starting dynamic subtest: pipe-B-eDP-1 [678.896680] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [678.905850] Starting dynamic subtest: pipe-C-eDP-1 [678.908622] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [678.917566] Starting dynamic subtest: pipe-D-eDP-1 [678.919909] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [678.922418] Subtest uint-max-clock: SUCCESS (0.304s) [679.757451] [117/133] (342s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs) [679.866736] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs [679.869214] Starting dynamic subtest: pipe-A-eDP-1 [679.894962] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [679.905597] Starting dynamic subtest: pipe-B-eDP-1 [679.931143] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [679.940170] Starting dynamic subtest: pipe-C-eDP-1 [679.965202] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [679.973819] Starting dynamic subtest: pipe-D-eDP-1 [679.999315] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [680.004543] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s) [682.024431] [118/133] (340s left) gem_exec_schedule (semaphore-noskip) [682.094365] Starting subtest: semaphore-noskip [682.549955] Subtest semaphore-noskip: SUCCESS (0.465s) [682.879534] [119/133] (339s left) kms_content_protection (atomic) [683.020393] Starting subtest: atomic [683.025778] Subtest atomic: SKIP (0.000s) [683.140652] [120/133] (339s left) prime_mmap_coherency (ioctl-errors) [683.198538] Starting subtest: ioctl-errors [706.007578] Subtest ioctl-errors: SUCCESS (22.814s) [706.154014] [121/133] (316s left) kms_rotation_crc (bad-tiling) [706.278076] Starting subtest: bad-tiling [706.281950] Subtest bad-tiling: SKIP (0.001s) [706.351577] [122/133] (316s left) kms_async_flips (invalid-async-flip) [706.440955] Starting subtest: invalid-async-flip [706.803556] Starting dynamic subtest: pipe-A-eDP-1 [707.642470] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.840s) [708.048057] Starting dynamic subtest: pipe-B-eDP-1 [708.766675] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.730s) [709.128681] Starting dynamic subtest: pipe-C-eDP-1 [709.888630] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.769s) [710.244562] Starting dynamic subtest: pipe-D-eDP-1 [711.019349] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.782s) [711.021566] Subtest invalid-async-flip: SUCCESS (4.581s) [712.166701] [123/133] (310s left) syncobj_timeline (wait-all-snapshot) [712.242075] Starting subtest: wait-all-snapshot [712.325199] Subtest wait-all-snapshot: SUCCESS (0.083s) [712.402811] [124/133] (310s left) gem_render_copy_redux (normal) [712.466251] Starting subtest: normal [712.805871] Subtest normal: SUCCESS (0.340s) [712.913515] [125/133] (309s left) kms_properties (invalid-properties-atomic) [713.009303] Starting subtest: invalid-properties-atomic [713.308135] Subtest invalid-properties-atomic: SUCCESS (0.299s) [713.383413] [126/133] (309s left) syncobj_wait (invalid-signal-one-illegal-handle) [713.441926] Starting subtest: invalid-signal-one-illegal-handle [713.444989] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [713.544973] [127/133] (309s left) kms_psr (fbc-pr-cursor-plane-onoff) [713.639862] Starting subtest: fbc-pr-cursor-plane-onoff [713.644721] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [713.715826] [128/133] (309s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render) [713.806532] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render [713.811670] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [713.904419] [129/133] (309s left) kms_plane_cursor (viewport) [713.991329] Starting subtest: viewport [713.995998] Starting dynamic subtest: pipe-A-eDP-1-size-64 [716.565357] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.575s) [716.625596] Starting dynamic subtest: pipe-A-eDP-1-size-128 [719.111674] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.493s) [719.169968] Starting dynamic subtest: pipe-A-eDP-1-size-256 [721.599718] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.439s) [721.949595] Starting dynamic subtest: pipe-B-eDP-1-size-64 [725.203642] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.265s) [725.263849] Starting dynamic subtest: pipe-B-eDP-1-size-128 [727.794708] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.538s) [727.853810] Starting dynamic subtest: pipe-B-eDP-1-size-256 [730.317564] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.470s) [730.675683] Starting dynamic subtest: pipe-C-eDP-1-size-64 [733.534245] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.868s) [733.571860] Starting dynamic subtest: pipe-C-eDP-1-size-128 [735.710700] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s) [735.750568] Starting dynamic subtest: pipe-C-eDP-1-size-256 [737.888198] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.146s) [738.221947] Starting dynamic subtest: pipe-D-eDP-1-size-64 [741.083808] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.875s) [741.121766] Starting dynamic subtest: pipe-D-eDP-1-size-128 [743.271555] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.158s) [743.310852] Starting dynamic subtest: pipe-D-eDP-1-size-256 [745.415099] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.113s) [745.742746] Subtest viewport: SUCCESS (31.755s) [746.598179] [130/133] (276s left) fbdev (info) [746.632907] Starting subtest: info [746.635400] Subtest info: SUCCESS (0.000s) [746.702784] [131/133] (276s left) kms_pm_rpm (modeset-lpsp-stress) [748.355705] Starting subtest: modeset-lpsp-stress [764.249855] Subtest modeset-lpsp-stress: SUCCESS (15.898s) [764.371849] [132/133] (258s left) gem_busy (close-race) [764.429671] Starting subtest: close-race [788.249613] Subtest close-race: SUCCESS (23.821s) [788.614706] [133/133] (234s left) api_intel_bb (misplaced-blitter) [788.703696] Starting subtest: misplaced-blitter [788.715379] Subtest misplaced-blitter: SUCCESS (0.014s) [788.827856] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: kms_flip_scaled_crc results: parsing output: 2/ for test: gem_ctx_param results: parsing output: 3/ for test: kms_chamelium_frames results: parsing output: 4/ for test: gem_exec_parallel results: parsing output: 5/ for test: gem_exec_flush results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: gem_wait results: parsing output: 8/ for test: gen9_exec_parse results: parsing output: 9/ for test: kms_psr results: parsing output: 10/ for test: prime_busy results: parsing output: 11/ for test: syncobj_timeline results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: gem_exec_balancer results: parsing output: 14/ for test: kms_scaling_modes results: parsing output: 15/ for test: gem_mmap results: parsing output: 16/ for test: api_intel_allocator results: parsing output: 17/ for test: kms_ccs results: parsing output: 18/ for test: gem_render_copy results: parsing output: 19/ for test: kms_flip results: parsing output: 20/ for test: gem_bad_reloc results: parsing output: 21/ for test: gem_create results: parsing output: 22/ for test: gem_userptr_blits results: parsing output: 23/ for test: kms_flip_scaled_crc results: parsing output: 24/ for test: gem_softpin results: parsing output: 25/ for test: gem_media_fill results: parsing output: 26/ for test: kms_vblank results: parsing output: 27/ for test: sw_sync results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: gem_partial_pwrite_pread results: parsing output: 30/ for test: kms_color results: parsing output: 31/ for test: gem_linear_blits results: parsing output: 32/ for test: i915_pm_rps results: parsing output: 33/ for test: gem_mmap_wc results: parsing output: 34/ for test: kms_lease results: parsing output: 35/ for test: gem_ctx_persistence results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: gem_exec_balancer results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: gem_ppgtt results: parsing output: 41/ for test: kms_ccs results: parsing output: 42/ for test: gem_workarounds results: parsing output: 43/ for test: kms_vrr results: parsing output: 44/ for test: gem_mmap results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_plane results: parsing output: 47/ for test: kms_hdr results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_cursor_crc results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: kms_draw_crc results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: perf_pmu results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: syncobj_wait results: parsing output: 56/ for test: kms_pipe_crc_basic results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: kms_cdclk results: parsing output: 59/ for test: kms_vblank results: parsing output: 60/ for test: gem_mmap_offset results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_properties results: parsing output: 63/ for test: kms_chamelium_hpd results: parsing output: 64/ for test: syncobj_wait results: parsing output: 65/ for test: kms_psr results: parsing output: 66/ for test: kms_plane results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: syncobj_basic results: parsing output: 69/ for test: kms_big_fb results: parsing output: 70/ for test: i915_drm_fdinfo results: parsing output: 71/ for test: kms_cursor_legacy results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_cursor_legacy results: parsing output: 74/ for test: gem_lmem_swapping results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_flip results: parsing output: 78/ for test: kms_rotation_crc results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: gem_exec_fence results: parsing output: 81/ for test: kms_flip results: parsing output: 82/ for test: gem_set_tiling_vs_blt results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_cursor_crc results: parsing output: 86/ for test: kms_pm_rpm results: parsing output: 87/ for test: kms_flip results: parsing output: 88/ for test: kms_cursor_legacy results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_cursor_edge_walk results: parsing output: 91/ for test: kms_busy results: parsing output: 92/ for test: gem_mmap_wc results: parsing output: 93/ for test: sw_sync results: parsing output: 94/ for test: syncobj_timeline results: parsing output: 95/ for test: gem_exec_reloc results: parsing output: 96/ for test: i915_pm_rpm results: parsing output: 97/ for test: i915_module_load results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_pxp results: parsing output: 100/ for test: drm_mm results: parsing output: 101/ for test: kms_plane_scaling results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: vgem_basic results: parsing output: 104/ for test: gem_exec_params results: parsing output: 105/ for test: syncobj_eventfd results: parsing output: 106/ for test: gem_exec_alignment results: parsing output: 107/ for test: syncobj_timeline results: parsing output: 108/ for test: kms_async_flips results: parsing output: 109/ for test: kms_flip results: parsing output: 110/ for test: kms_rmfb results: parsing output: 111/ for test: gem_exec_schedule results: parsing output: 112/ for test: gem_eio results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: kms_psr2_sf results: parsing output: 115/ for test: kms_invalid_mode results: parsing output: 116/ for test: kms_ccs results: parsing output: 117/ for test: gem_exec_schedule results: parsing output: 118/ for test: kms_content_protection results: parsing output: 119/ for test: prime_mmap_coherency results: parsing output: 120/ for test: kms_rotation_crc results: parsing output: 121/ for test: kms_async_flips results: parsing output: 122/ for test: syncobj_timeline results: parsing output: 123/ for test: gem_render_copy_redux results: parsing output: 124/ for test: kms_properties results: parsing output: 125/ for test: syncobj_wait results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_plane_cursor results: parsing output: 129/ for test: fbdev results: parsing output: 130/ for test: kms_pm_rpm results: parsing output: 131/ for test: gem_busy results: parsing output: 132/ for test: api_intel_bb Done.