[57.480458] Initializing watchdogs [57.480505] /dev/watchdog0 [57.494973] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [57.498960] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.501490] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.504800] [001/133] (960s left) gem_exec_nop (basic-sequential) [57.601643] Starting subtest: basic-sequential [72.343254] Subtest basic-sequential: SUCCESS (14.811s) [72.556480] [002/133] (945s left) kms_big_fb (y-tiled-32bpp-rotate-90) [72.637798] Starting subtest: y-tiled-32bpp-rotate-90 [72.642091] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [72.729634] [003/133] (945s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [72.821566] Starting subtest: fbc-rgb101010-draw-render [77.429912] Subtest fbc-rgb101010-draw-render: SUCCESS (4.616s) [78.594610] [004/133] (939s left) kms_plane_multiple (2x-tiling-4) [78.664422] Starting subtest: 2x-tiling-4 [78.668631] Subtest 2x-tiling-4: SKIP (0.000s) [78.733091] [005/133] (939s left) perf_pmu (semaphore-busy) [78.774070] Starting subtest: semaphore-busy [78.776373] Starting dynamic subtest: rcs0 [80.427124] Dynamic subtest rcs0: SUCCESS (1.649s) [80.437067] Starting dynamic subtest: bcs0 [82.057934] Dynamic subtest bcs0: SUCCESS (1.629s) [82.068737] Starting dynamic subtest: vcs0 [86.292127] Dynamic subtest vcs0: SUCCESS (4.232s) [86.301853] Starting dynamic subtest: vcs1 [91.347894] Dynamic subtest vcs1: SUCCESS (5.053s) [91.358275] Starting dynamic subtest: vecs0 [97.364795] Dynamic subtest vecs0: SUCCESS (6.014s) [97.375355] Starting dynamic subtest: ccs0 [100.437038] Dynamic subtest ccs0: SUCCESS (3.070s) [100.439532] Subtest semaphore-busy: SUCCESS (21.653s) [100.546990] [006/133] (917s left) kms_psr (psr2-primary-page-flip) [100.630412] Starting subtest: psr2-primary-page-flip [100.632816] Starting dynamic subtest: eDP-1 [102.384092] Dynamic subtest eDP-1: SUCCESS (1.754s) [102.386379] Subtest psr2-primary-page-flip: SUCCESS (1.755s) [103.239300] [007/133] (914s left) i915_suspend (fence-restore-tiled2untiled) [103.293270] Starting subtest: fence-restore-tiled2untiled [103.297607] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [103.391647] [008/133] (914s left) gem_exec_balancer (busy) [103.454075] Starting subtest: busy [104.855807] Subtest busy: SUCCESS (1.399s) [105.156326] [009/133] (913s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [105.236815] Starting subtest: primary-yf-tiled-reflect-x-180 [105.297281] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [105.400812] [010/133] (912s left) gem_exec_reloc (basic-wc-gtt-noreloc) [105.470424] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [105.547715] [011/133] (912s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [105.629019] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [105.631381] Starting dynamic subtest: pipe-A-default-mode [106.798734] Dynamic subtest pipe-A-default-mode: SKIP (1.167s) [106.803286] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.168s) [106.950557] [012/133] (911s left) kms_tiled_display (basic-test-pattern-with-chamelium) [107.039609] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s) [107.082676] [013/133] (911s left) gem_exec_fence (syncobj-timeline-export) [107.640580] Starting subtest: syncobj-timeline-export [107.645512] Subtest syncobj-timeline-export: SUCCESS (0.010s) [108.919319] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true [108.921904] [014/133] (909s left) gen7_exec_parse (bitmasks) [108.985310] Subtest bitmasks: SKIP (0.000s) [109.060332] [015/133] (909s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [109.130965] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [109.157516] Starting dynamic subtest: pipe-A-plane-0 [109.779947] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s) [109.788263] Starting dynamic subtest: pipe-A-plane-3 [110.169261] Dynamic subtest pipe-A-plane-3: SUCCESS (0.388s) [111.256629] Starting dynamic subtest: pipe-B-plane-0 [111.918089] Dynamic subtest pipe-B-plane-0: SUCCESS (0.667s) [111.926052] Starting dynamic subtest: pipe-B-plane-3 [112.339774] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s) [112.654076] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.523s) [113.531035] [016/133] (905s left) syncobj_timeline (single-wait-for-submit-available-signaled) [113.594056] Starting subtest: single-wait-for-submit-available-signaled [113.596503] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [113.706399] [017/133] (904s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [113.795658] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [113.800165] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [113.895627] [018/133] (904s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode) [114.266867] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s) [115.048506] [019/133] (903s left) kms_pm_rpm (dpms-mode-unset-lpsp) [116.974512] Starting subtest: dpms-mode-unset-lpsp [121.029823] Subtest dpms-mode-unset-lpsp: SUCCESS (4.057s) [121.427925] [020/133] (897s left) kms_big_fb (yf-tiled-addfb) [121.527320] Starting subtest: yf-tiled-addfb [121.532444] Subtest yf-tiled-addfb: SKIP (0.000s) [121.618079] [021/133] (897s left) gem_pxp (fail-invalid-protected-context) [121.745314] Starting subtest: fail-invalid-protected-context [121.747803] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [121.871393] [022/133] (896s left) kms_atomic_interruptible (legacy-cursor) [121.942958] Starting subtest: legacy-cursor [121.945270] Starting dynamic subtest: pipe-A-eDP-1 [129.321389] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.377s) [129.323409] Subtest legacy-cursor: SUCCESS (7.378s) [130.170031] [023/133] (888s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [130.254100] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [130.258885] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [130.344708] [024/133] (888s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [130.416055] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [130.418551] Starting dynamic subtest: pipe-A-eDP-1 [130.441885] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [130.451837] Starting dynamic subtest: pipe-B-eDP-1 [130.473999] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [130.482075] Starting dynamic subtest: pipe-C-eDP-1 [130.503504] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [130.510980] Starting dynamic subtest: pipe-D-eDP-1 [130.532412] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [130.536781] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s) [132.658305] [025/133] (886s left) gem_exec_fence (expired-history) [133.089847] Starting subtest: expired-history [140.615926] Subtest expired-history: SUCCESS (7.526s) [141.214217] [026/133] (877s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [141.263653] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [141.365773] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s) [141.440916] [027/133] (877s left) gem_ctx_engines (execute-allforone) [141.495063] Starting subtest: execute-allforone [141.515399] Subtest execute-allforone: SUCCESS (0.020s) [142.925577] [028/133] (876s left) gem_lmem_swapping (heavy-random) [142.974195] Subtest heavy-random: SKIP (0.000s) [143.022136] [029/133] (876s left) kms_cursor_crc (cursor-rapid-movement-512x512) [143.290864] Starting subtest: cursor-rapid-movement-512x512 [143.295854] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [143.469964] [030/133] (875s left) kms_getfb (getfb2-accept-nv12) [143.559988] Starting subtest: getfb2-accept-nv12 [143.562384] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [143.660457] [031/133] (875s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [143.772325] Starting subtest: basic-flip-before-cursor-atomic [144.697126] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.923s) [145.496714] [032/133] (873s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [145.557631] Starting subtest: x-tiled-to-vebox-yf-tiled [145.561640] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [145.738818] [033/133] (873s left) kms_pipe_stress (stress-xrgb8888-4tiled) [145.814530] Starting subtest: stress-xrgb8888-4tiled [151.592892] Subtest stress-xrgb8888-4tiled: SUCCESS (5.780s) [151.644728] [034/133] (867s left) gem_exec_suspend (basic) [151.713405] Starting subtest: basic [151.715533] Starting dynamic subtest: smem [152.858055] Dynamic subtest smem: SUCCESS (1.142s) [152.861300] Subtest basic: SUCCESS (1.143s) [153.066942] [035/133] (866s left) i915_hangman (engine-engine-error) [153.129348] Starting subtest: engine-engine-error [153.131244] Starting dynamic subtest: rcs0 [154.808392] Dynamic subtest rcs0: SUCCESS (1.678s) [154.819018] Starting dynamic subtest: bcs0 [156.791819] Dynamic subtest bcs0: SUCCESS (1.982s) [156.803127] Starting dynamic subtest: vcs0 [158.839494] Dynamic subtest vcs0: SUCCESS (2.046s) [158.859540] Starting dynamic subtest: vcs1 [160.759238] Dynamic subtest vcs1: SUCCESS (1.918s) [160.770593] Starting dynamic subtest: vecs0 [162.807267] Dynamic subtest vecs0: SUCCESS (2.047s) [162.818679] Starting dynamic subtest: ccs0 [164.791410] Dynamic subtest ccs0: SUCCESS (1.982s) [164.794494] Subtest engine-engine-error: SUCCESS (11.663s) [164.920304] [036/133] (854s left) perf (oa-formats) [165.051627] Starting subtest: oa-formats [165.053788] Starting dynamic subtest: 0-rcs0 [165.067850] Dynamic subtest 0-rcs0: SUCCESS (0.016s) [165.076528] Starting dynamic subtest: 1-vcs1 [165.091461] Dynamic subtest 1-vcs1: SUCCESS (0.023s) [165.093649] Subtest oa-formats: SUCCESS (0.041s) [165.143573] [037/133] (854s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [165.195019] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [165.199533] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [165.378393] [038/133] (854s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [165.472754] Starting subtest: cursorA-vs-flipB-toggle [165.477482] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [165.616854] [039/133] (853s left) gem_softpin (zero) [165.680504] Starting subtest: zero [165.686196] Subtest zero: SUCCESS (0.008s) [165.798318] [040/133] (853s left) kms_invalid_mode (bad-hsync-start) [165.873061] Starting subtest: bad-hsync-start [165.875281] Starting dynamic subtest: pipe-A-eDP-1 [166.155345] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [166.169892] Starting dynamic subtest: pipe-B-eDP-1 [166.172071] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [166.179583] Starting dynamic subtest: pipe-C-eDP-1 [166.181474] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [166.188638] Starting dynamic subtest: pipe-D-eDP-1 [166.190563] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [166.192484] Subtest bad-hsync-start: SUCCESS (0.289s) [167.024333] [041/133] (852s left) kms_flip (modeset-vs-vblank-race) [167.097127] Starting subtest: modeset-vs-vblank-race [167.099084] Starting dynamic subtest: A-eDP1 [171.824320] Dynamic subtest A-eDP1: SUCCESS (4.729s) [171.835567] Starting dynamic subtest: B-eDP1 [176.558057] Dynamic subtest B-eDP1: SUCCESS (4.731s) [176.567101] Starting dynamic subtest: C-eDP1 [181.183547] Dynamic subtest C-eDP1: SUCCESS (4.623s) [181.194250] Starting dynamic subtest: D-eDP1 [185.809113] Dynamic subtest D-eDP1: SUCCESS (4.624s) [185.814421] Subtest modeset-vs-vblank-race: SUCCESS (18.721s) [186.974619] [042/133] (832s left) gem_wait (invalid-flags) [187.055323] Starting subtest: invalid-flags [187.057737] Subtest invalid-flags: SUCCESS (0.000s) [187.291140] [043/133] (832s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [187.369770] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [191.591588] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.224s) [192.802044] [044/133] (826s left) gem_exec_fence (syncobj-timeline-signal) [193.359789] Starting subtest: syncobj-timeline-signal [193.365861] Subtest syncobj-timeline-signal: SUCCESS (0.007s) [194.945371] [045/133] (824s left) kms_psr (pr-cursor-plane-move) [195.041901] Starting subtest: pr-cursor-plane-move [195.046336] Subtest pr-cursor-plane-move: SKIP (0.000s) [195.112076] [046/133] (824s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [195.191626] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [195.195404] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [195.288338] [047/133] (824s left) sysfs_timeslice_duration (idempotent) [195.354859] Starting subtest: idempotent [195.357205] Starting dynamic subtest: vecs0 [195.359443] Dynamic subtest vecs0: SUCCESS (0.000s) [195.367074] Starting dynamic subtest: ccs0 [195.368991] Dynamic subtest ccs0: SUCCESS (0.000s) [195.376153] Starting dynamic subtest: vcs0 [195.377998] Dynamic subtest vcs0: SUCCESS (0.000s) [195.385346] Starting dynamic subtest: bcs0 [195.387310] Dynamic subtest bcs0: SUCCESS (0.000s) [195.394629] Starting dynamic subtest: rcs0 [195.396555] Dynamic subtest rcs0: SUCCESS (0.000s) [195.404731] Starting dynamic subtest: vcs1 [195.406956] Dynamic subtest vcs1: SUCCESS (0.000s) [195.409181] Subtest idempotent: SUCCESS (0.005s) [195.457950] [048/133] (824s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [195.545793] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [195.550249] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [195.644728] [049/133] (824s left) kms_draw_crc (draw-method-blt) [195.716973] Starting subtest: draw-method-blt [195.719257] Starting dynamic subtest: xrgb8888-untiled [195.960555] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s) [195.969315] Starting dynamic subtest: rgb565-untiled [196.182605] Dynamic subtest rgb565-untiled: SUCCESS (0.220s) [196.190608] Starting dynamic subtest: xrgb2101010-untiled [196.382602] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s) [196.390593] Starting dynamic subtest: xbgr16161616f-untiled [196.582576] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s) [196.590325] Starting dynamic subtest: xrgb8888-xtiled [196.693743] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s) [196.701336] Starting dynamic subtest: rgb565-xtiled [196.793733] Dynamic subtest rgb565-xtiled: SUCCESS (0.099s) [196.801343] Starting dynamic subtest: xrgb2101010-xtiled [196.904932] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [196.912853] Starting dynamic subtest: xbgr16161616f-xtiled [197.006117] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.099s) [197.014197] Starting dynamic subtest: xrgb8888-4tiled [197.127837] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s) [197.135910] Starting dynamic subtest: rgb565-4tiled [197.249690] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s) [197.257326] Starting dynamic subtest: xrgb2101010-4tiled [197.360791] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s) [197.368679] Starting dynamic subtest: xbgr16161616f-4tiled [197.471643] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s) [197.473635] Subtest draw-method-blt: SUCCESS (1.757s) [197.590798] [050/133] (822s left) kms_color (deep-color) [197.663411] Starting subtest: deep-color [198.755889] Starting dynamic subtest: pipe-A-eDP-1-gamma [199.488955] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.731s) [199.497447] Starting dynamic subtest: pipe-A-eDP-1-degamma [200.955441] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.465s) [200.964028] Starting dynamic subtest: pipe-A-eDP-1-ctm [202.370259] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.412s) [203.136404] Starting dynamic subtest: pipe-B-eDP-1-gamma [203.837202] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.707s) [203.846095] Starting dynamic subtest: pipe-B-eDP-1-degamma [205.309218] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.471s) [205.318046] Starting dynamic subtest: pipe-B-eDP-1-ctm [206.739342] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.430s) [207.519802] Starting dynamic subtest: pipe-C-eDP-1-gamma [208.205362] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.692s) [208.214257] Starting dynamic subtest: pipe-C-eDP-1-degamma [209.578786] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.375s) [209.587680] Starting dynamic subtest: pipe-C-eDP-1-ctm [211.011101] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.429s) [211.807198] Starting dynamic subtest: pipe-D-eDP-1-gamma [212.509562] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.706s) [212.517829] Starting dynamic subtest: pipe-D-eDP-1-degamma [213.979192] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.468s) [213.989128] Starting dynamic subtest: pipe-D-eDP-1-ctm [215.414961] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.436s) [215.417352] Subtest deep-color: SUCCESS (17.750s) [216.265106] [051/133] (803s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [216.347861] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [216.352092] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s) [216.421191] [052/133] (803s left) gem_mmap_gtt (medium-copy) [216.464708] Subtest medium-copy: SKIP (0.000s) [216.524555] [053/133] (803s left) kms_psr (psr-dpms) [216.598157] Starting subtest: psr-dpms [216.600600] Starting dynamic subtest: eDP-1 [219.592174] Dynamic subtest eDP-1: SUCCESS (2.994s) [219.594552] Subtest psr-dpms: SUCCESS (2.996s) [220.441763] [054/133] (799s left) syncobj_timeline (invalid-wait-illegal-handle) [220.486193] Starting subtest: invalid-wait-illegal-handle [220.488061] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [220.585008] [055/133] (799s left) kms_pm_rpm (system-suspend-idle) [222.076033] Starting subtest: system-suspend-idle [241.250837] Subtest system-suspend-idle: SUCCESS (4.358s) [241.605197] [056/133] (778s left) kms_big_fb (4-tiled-addfb-size-overflow) [241.699883] Starting subtest: 4-tiled-addfb-size-overflow [241.702016] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [241.796223] [057/133] (778s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [241.886094] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [248.707939] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.953s) [248.813861] [058/133] (771s left) kms_plane (plane-position-covered) [248.887635] Starting subtest: plane-position-covered [249.398843] Starting dynamic subtest: pipe-A-plane-1 [250.645762] Dynamic subtest pipe-A-plane-1: SUCCESS (1.258s) [250.657427] Starting dynamic subtest: pipe-A-plane-2 [251.950750] Dynamic subtest pipe-A-plane-2: SUCCESS (1.316s) [251.959729] Starting dynamic subtest: pipe-A-plane-3 [253.173859] Dynamic subtest pipe-A-plane-3: SUCCESS (1.231s) [253.183122] Starting dynamic subtest: pipe-A-plane-4 [254.409177] Dynamic subtest pipe-A-plane-4: SUCCESS (1.242s) [254.418811] Starting dynamic subtest: pipe-A-plane-5 [254.435266] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s) [255.570422] Starting dynamic subtest: pipe-B-plane-1 [256.835008] Dynamic subtest pipe-B-plane-1: SUCCESS (1.281s) [256.844699] Starting dynamic subtest: pipe-B-plane-2 [258.149005] Dynamic subtest pipe-B-plane-2: SUCCESS (1.319s) [258.159708] Starting dynamic subtest: pipe-B-plane-3 [259.452091] Dynamic subtest pipe-B-plane-3: SUCCESS (1.305s) [259.461543] Starting dynamic subtest: pipe-B-plane-4 [260.674085] Dynamic subtest pipe-B-plane-4: SUCCESS (1.224s) [260.683605] Starting dynamic subtest: pipe-B-plane-5 [260.699174] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s) [260.701410] Subtest plane-position-covered: SUCCESS (11.881s) [261.480035] [059/133] (758s left) gem_exec_whisper (basic-contexts-all) [261.548431] Starting subtest: basic-contexts-all [271.514665] Subtest basic-contexts-all: SUCCESS (9.978s) [271.696629] [060/133] (748s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [271.776292] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [271.780480] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [271.859078] [061/133] (748s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [271.940412] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [271.944253] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [272.037032] [062/133] (748s left) kms_joiner (invalid-modeset-ultra-joiner) [272.116633] Starting subtest: invalid-modeset-ultra-joiner [272.120986] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [272.181918] [063/133] (748s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [272.262094] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt [272.266126] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [272.361797] [064/133] (748s left) gem_bad_reloc (negative-reloc-lut) [272.418808] Subtest negative-reloc-lut: SKIP (0.000s) [272.477132] [065/133] (748s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [272.546729] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [272.550877] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [272.633988] [066/133] (747s left) syncobj_timeline (multi-wait-for-submit-signaled) [272.685822] Starting subtest: multi-wait-for-submit-signaled [272.687714] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [272.782963] [067/133] (747s left) gem_mmap_offset (partial-remap) [272.829699] Starting subtest: partial-remap [272.831658] Starting dynamic subtest: smem0 [272.839269] Dynamic subtest smem0: SUCCESS (0.004s) [272.841150] Subtest partial-remap: SUCCESS (0.005s) [272.916637] [068/133] (747s left) gem_mmap_gtt (cpuset-basic-small-copy) [272.966668] Subtest cpuset-basic-small-copy: SKIP (0.000s) [273.023527] [069/133] (747s left) kms_frontbuffer_tracking (fbc-tiling-4) [273.103150] Starting subtest: fbc-tiling-4 [277.257083] Subtest fbc-tiling-4: SUCCESS (4.156s) [278.385840] [070/133] (742s left) kms_cursor_crc (cursor-offscreen-32x10) [278.539148] Starting subtest: cursor-offscreen-32x10 [278.585732] Subtest cursor-offscreen-32x10: SKIP (0.042s) [278.852503] [071/133] (741s left) kms_psr (fbc-psr2-primary-mmap-cpu) [278.935204] Starting subtest: fbc-psr2-primary-mmap-cpu [278.937553] Starting dynamic subtest: eDP-1 [278.942000] Dynamic subtest eDP-1: SKIP (0.000s) [278.946420] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s) [279.005814] [072/133] (741s left) perf_pmu (idle) [279.045208] Starting subtest: idle [279.047058] Starting dynamic subtest: rcs0 [279.596297] Dynamic subtest rcs0: SUCCESS (0.550s) [279.608351] Starting dynamic subtest: bcs0 [280.117056] Dynamic subtest bcs0: SUCCESS (0.518s) [280.129565] Starting dynamic subtest: vcs0 [280.631997] Dynamic subtest vcs0: SUCCESS (0.512s) [280.643345] Starting dynamic subtest: vcs1 [281.147050] Dynamic subtest vcs1: SUCCESS (0.513s) [281.158048] Starting dynamic subtest: vecs0 [281.663121] Dynamic subtest vecs0: SUCCESS (0.513s) [281.675039] Starting dynamic subtest: ccs0 [282.183658] Dynamic subtest ccs0: SUCCESS (0.518s) [282.186635] Subtest idle: SUCCESS (3.139s) [282.302360] [073/133] (738s left) syncobj_wait (single-wait-all-for-submit-signaled) [282.354318] Starting subtest: single-wait-all-for-submit-signaled [282.356562] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [282.459889] [074/133] (738s left) kms_big_fb (x-tiled-64bpp-rotate-90) [282.541251] Starting subtest: x-tiled-64bpp-rotate-90 [282.561595] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s) [282.673398] [075/133] (738s left) api_intel_allocator (default-alignment) [282.726847] Starting subtest: default-alignment [282.729856] Subtest default-alignment: SUCCESS (0.004s) [282.850843] [076/133] (738s left) gem_ctx_shared (q-out-order) [282.909879] Starting subtest: Q-out-order [282.912286] Starting dynamic subtest: rcs0 [283.037117] Dynamic subtest rcs0: SUCCESS (0.125s) [283.048617] Starting dynamic subtest: vcs0 [283.132132] Dynamic subtest vcs0: SUCCESS (0.095s) [283.150688] Starting dynamic subtest: vcs1 [283.217873] Dynamic subtest vcs1: SUCCESS (0.085s) [283.236797] Starting dynamic subtest: vecs0 [283.294677] Dynamic subtest vecs0: SUCCESS (0.076s) [283.310840] Starting dynamic subtest: ccs0 [283.370545] Dynamic subtest ccs0: SUCCESS (0.074s) [283.373471] Subtest Q-out-order: SUCCESS (0.460s) [284.815885] [077/133] (736s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [284.901179] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [284.905415] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [285.009253] [078/133] (736s left) syncobj_timeline (etime-multi-wait-all-submitted) [285.070843] Starting subtest: etime-multi-wait-all-submitted [285.178813] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s) [285.253671] [079/133] (735s left) perf (gen12-invalid-class-instance) [285.331920] Starting subtest: gen12-invalid-class-instance [285.343165] Subtest gen12-invalid-class-instance: SUCCESS (0.009s) [285.388920] [080/133] (735s left) kms_cursor_legacy (single-move) [285.493748] Starting subtest: single-move [285.496092] Starting dynamic subtest: pipe-A [290.875983] Dynamic subtest pipe-A: SUCCESS (5.379s) [290.887637] Starting dynamic subtest: pipe-B [296.258849] Dynamic subtest pipe-B: SUCCESS (5.380s) [296.270527] Starting dynamic subtest: pipe-C [301.639568] Dynamic subtest pipe-C: SUCCESS (5.379s) [301.648481] Starting dynamic subtest: pipe-D [307.021293] Dynamic subtest pipe-D: SUCCESS (5.380s) [307.031235] Starting dynamic subtest: all-pipes [312.413090] Dynamic subtest all-pipes: SUCCESS (5.386s) [312.415555] Subtest single-move: SUCCESS (26.918s) [312.568690] [081/133] (708s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [312.660260] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [321.088825] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.425s) [321.196171] [082/133] (700s left) gem_pwrite_snooped [321.319709] [083/133] (699s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [321.424309] Starting subtest: cursorB-vs-flipB-toggle [321.429451] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [321.570375] [084/133] (699s left) gem_mmap_gtt (basic-write-read-distinct) [321.633168] Subtest basic-write-read-distinct: SKIP (0.000s) [321.700263] [085/133] (699s left) syncobj_wait (reset-multiple-signaled) [321.765405] Starting subtest: reset-multiple-signaled [321.767825] Subtest reset-multiple-signaled: SUCCESS (0.000s) [321.852183] [086/133] (699s left) kms_concurrent (multi-plane-atomic-lowres) [321.938882] Starting subtest: multi-plane-atomic-lowres [321.940727] Starting dynamic subtest: pipe-A-eDP-1 [322.433573] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.496s) [322.443062] Starting dynamic subtest: pipe-B-eDP-1 [323.725815] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.291s) [323.734464] Starting dynamic subtest: pipe-C-eDP-1 [324.911530] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.182s) [324.920928] Starting dynamic subtest: pipe-D-eDP-1 [326.159923] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s) [326.162211] Subtest multi-plane-atomic-lowres: SUCCESS (4.222s) [326.966021] [087/133] (694s left) api_intel_bb (object-noreloc-keep-cache-simple) [327.033435] Starting subtest: object-noreloc-keep-cache-simple [327.039240] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s) [327.157329] [088/133] (694s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [327.227653] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [327.230143] Starting dynamic subtest: pipe-A-eDP-1 [327.253768] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [327.265700] Starting dynamic subtest: pipe-B-eDP-1 [327.287588] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [327.295881] Starting dynamic subtest: pipe-C-eDP-1 [327.317373] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [327.325827] Starting dynamic subtest: pipe-D-eDP-1 [327.347845] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [327.352140] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s) [329.538063] [089/133] (691s left) kms_big_fb (linear-8bpp-rotate-90) [329.625071] Starting subtest: linear-8bpp-rotate-90 [329.645937] Subtest linear-8bpp-rotate-90: SKIP (0.020s) [329.751465] [090/133] (691s left) i915_drm_fdinfo (busy) [329.791538] Starting subtest: busy [329.793846] Starting dynamic subtest: rcs0 [329.817498] Dynamic subtest rcs0: SKIP (0.024s) [329.826849] Starting dynamic subtest: bcs0 [329.831068] Dynamic subtest bcs0: SKIP (0.001s) [329.839447] Starting dynamic subtest: vcs0 [329.843579] Dynamic subtest vcs0: SKIP (0.000s) [329.851934] Starting dynamic subtest: vcs1 [329.855916] Dynamic subtest vcs1: SKIP (0.000s) [329.863815] Starting dynamic subtest: vecs0 [329.867815] Dynamic subtest vecs0: SKIP (0.000s) [329.876028] Starting dynamic subtest: ccs0 [329.880024] Dynamic subtest ccs0: SKIP (0.000s) [329.884024] Subtest busy: SKIP (0.031s) [329.920154] [091/133] (691s left) kms_cursor_edge_walk (64x64-right-edge) [329.991231] Starting subtest: 64x64-right-edge [329.993421] Starting dynamic subtest: pipe-A-eDP-1 [333.484374] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.492s) [333.494761] Starting dynamic subtest: pipe-D-eDP-1 [336.625778] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.140s) [336.628368] Subtest 64x64-right-edge: SUCCESS (6.635s) [337.419327] [092/133] (684s left) gem_exec_reloc (basic-cpu-gtt-active) [337.491276] Subtest basic-cpu-gtt-active: SKIP (0.000s) [337.567616] [093/133] (684s left) gem_exec_params (batch-first) [337.622150] Starting subtest: batch-first [337.630664] Subtest batch-first: SUCCESS (0.008s) [337.772442] [094/133] (683s left) kms_chamelium_edid (dp-edid-change-during-suspend) [338.136722] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [338.935140] [095/133] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [339.018774] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [339.023330] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [339.109070] [096/133] (682s left) core_getversion (basic) [339.153052] Starting subtest: basic [339.157648] Subtest basic: SUCCESS (0.000s) [339.214874] [097/133] (682s left) kms_chamelium_color (ctm-max) [339.290620] Subtest ctm-max: SKIP (0.000s) [339.334866] [098/133] (682s left) prime_mmap (test_userptr) [339.391414] Starting subtest: test_userptr [339.393702] Starting dynamic subtest: test_userptr-smem [339.395706] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [339.397694] Subtest test_userptr: SUCCESS (0.001s) [339.482630] [099/133] (682s left) gem_ctx_persistence (userptr) [339.544283] Starting subtest: userptr [339.716351] Subtest userptr: SUCCESS (0.172s) [339.791105] [100/133] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [339.881235] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [339.884668] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [339.977656] [101/133] (682s left) kms_flip (flip-vs-panning-interruptible) [340.049877] Starting subtest: flip-vs-panning-interruptible [340.051735] Starting dynamic subtest: A-eDP1 [348.777927] Dynamic subtest A-eDP1: SUCCESS (8.721s) [348.788135] Starting dynamic subtest: B-eDP1 [357.506517] Dynamic subtest B-eDP1: SUCCESS (8.727s) [357.517596] Starting dynamic subtest: C-eDP1 [366.224793] Dynamic subtest C-eDP1: SUCCESS (8.715s) [366.234011] Starting dynamic subtest: D-eDP1 [374.864336] Dynamic subtest D-eDP1: SUCCESS (8.639s) [374.868594] Subtest flip-vs-panning-interruptible: SUCCESS (34.812s) [376.023648] [102/133] (646s left) kms_flip (plain-flip-fb-recreate) [376.124849] Starting subtest: plain-flip-fb-recreate [376.127270] Starting dynamic subtest: A-eDP1 [385.027682] Dynamic subtest A-eDP1: SUCCESS (8.903s) [385.040697] Starting dynamic subtest: B-eDP1 [393.854739] Dynamic subtest B-eDP1: SUCCESS (8.825s) [393.863240] Starting dynamic subtest: C-eDP1 [402.686465] Dynamic subtest C-eDP1: SUCCESS (8.832s) [402.695264] Starting dynamic subtest: D-eDP1 [411.515005] Dynamic subtest D-eDP1: SUCCESS (8.828s) [411.518938] Subtest plain-flip-fb-recreate: SUCCESS (35.400s) [412.692328] [103/133] (609s left) kms_psr2_sf (psr2-cursor-plane-update-sf) [412.777348] Starting subtest: psr2-cursor-plane-update-sf [412.779733] Starting dynamic subtest: pipe-A-eDP-1 [413.337344] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s) [413.346582] Starting dynamic subtest: pipe-B-eDP-1 [414.587447] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.249s) [414.589887] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.817s) [415.464559] [104/133] (606s left) gen7_exec_parse (basic-allowed) [415.519030] Subtest basic-allowed: SKIP (0.000s) [415.588630] [105/133] (606s left) gem_exec_reloc (basic-wc-gtt) [415.649004] Subtest basic-wc-gtt: SKIP (0.000s) [415.720240] [106/133] (606s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [415.803718] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [415.807773] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [415.901301] [107/133] (606s left) kms_pwrite_crc [417.484887] [108/133] (604s left) kms_psr (fbc-psr-primary-mmap-gtt) [417.559817] Starting subtest: fbc-psr-primary-mmap-gtt [417.562081] Starting dynamic subtest: eDP-1 [417.566364] Dynamic subtest eDP-1: SKIP (0.000s) [417.570646] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s) [417.637224] [109/133] (604s left) gem_ctx_isolation (dirty-switch) [417.711925] Starting subtest: dirty-switch [417.714088] Starting dynamic subtest: rcs0 [417.913904] Dynamic subtest rcs0: SUCCESS (0.204s) [417.925778] Starting dynamic subtest: bcs0 [418.110694] Dynamic subtest bcs0: SUCCESS (0.196s) [418.122245] Starting dynamic subtest: vcs0 [418.346577] Dynamic subtest vcs0: SUCCESS (0.235s) [418.358011] Starting dynamic subtest: vcs1 [419.864522] Dynamic subtest vcs1: SUCCESS (1.518s) [419.874056] Starting dynamic subtest: vecs0 [421.947501] Dynamic subtest vecs0: SUCCESS (2.083s) [421.956610] Starting dynamic subtest: ccs0 [423.950477] Dynamic subtest ccs0: SUCCESS (2.002s) [423.952975] Subtest dirty-switch: SUCCESS (6.243s) [424.194813] [110/133] (598s left) gem_ctx_param (set-priority-not-supported) [424.261957] Starting subtest: set-priority-not-supported [424.266832] Subtest set-priority-not-supported: SKIP (0.000s) [424.342882] [111/133] (598s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [424.414898] Starting subtest: plane-upscale-factor-0-25-with-rotation [424.417190] Starting dynamic subtest: pipe-A [424.640688] Dynamic subtest pipe-A: SUCCESS (0.228s) [424.650672] Starting dynamic subtest: pipe-B [425.965728] Dynamic subtest pipe-B: SUCCESS (1.325s) [425.975572] Starting dynamic subtest: pipe-C [427.300221] Dynamic subtest pipe-C: SUCCESS (1.333s) [427.309778] Starting dynamic subtest: pipe-D [428.632456] Dynamic subtest pipe-D: SUCCESS (1.332s) [428.634856] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.221s) [429.814030] [112/133] (592s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [429.900663] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [430.991521] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.090s) [431.100629] [113/133] (591s left) sw_sync (sync_busy) [431.135439] Starting subtest: sync_busy [431.137712] Subtest sync_busy: SUCCESS (0.002s) [431.187729] [114/133] (591s left) i915_pm_rpm (debugfs-forcewake-user) [432.884013] Starting subtest: debugfs-forcewake-user [444.262445] Subtest debugfs-forcewake-user: SUCCESS (11.381s) [444.637380] [115/133] (577s left) gem_exec_schedule (u-semaphore-codependency) [444.729128] Starting subtest: u-semaphore-codependency [444.734399] Subtest u-semaphore-codependency: SUCCESS (0.012s) [445.078461] [116/133] (577s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [445.151539] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [445.153856] Starting dynamic subtest: pipe-A-eDP-1 [445.175579] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [445.185506] Starting dynamic subtest: pipe-B-eDP-1 [445.204147] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [445.212520] Starting dynamic subtest: pipe-C-eDP-1 [445.233867] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [445.242045] Starting dynamic subtest: pipe-D-eDP-1 [445.263050] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [445.267355] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s) [447.377031] [117/133] (575s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [447.451523] Starting subtest: bad-rotation-90-yf-tiled-ccs [447.453775] Starting dynamic subtest: pipe-A-eDP-1 [447.475468] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [447.485597] Starting dynamic subtest: pipe-B-eDP-1 [447.506552] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [447.515209] Starting dynamic subtest: pipe-C-eDP-1 [447.536661] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [447.545029] Starting dynamic subtest: pipe-D-eDP-1 [447.568047] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [447.572511] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s) [449.654596] [118/133] (573s left) kms_addfb_basic (bad-pitch-256) [449.708855] Starting subtest: bad-pitch-256 [449.711051] Subtest bad-pitch-256: SUCCESS (0.000s) [449.823644] [119/133] (572s left) kms_flip (2x-flip-vs-modeset-vs-hang) [449.891429] Starting subtest: 2x-flip-vs-modeset-vs-hang [449.898399] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.007s) [449.977256] [120/133] (572s left) gem_exec_schedule (manyslice) [450.044231] Starting subtest: manyslice [450.046532] Starting dynamic subtest: rcs0 [455.154650] Dynamic subtest rcs0: SUCCESS (5.120s) [455.168042] Starting dynamic subtest: bcs0 [461.767982] Dynamic subtest bcs0: SUCCESS (6.613s) [461.780857] Starting dynamic subtest: vcs0 [466.847649] Dynamic subtest vcs0: SUCCESS (5.078s) [466.861159] Starting dynamic subtest: vcs1 [472.925359] Dynamic subtest vcs1: SUCCESS (6.074s) [472.938662] Starting dynamic subtest: vecs0 [478.479302] Dynamic subtest vecs0: SUCCESS (5.551s) [478.490539] Starting dynamic subtest: ccs0 [484.109446] Dynamic subtest ccs0: SUCCESS (5.627s) [484.111852] Subtest manyslice: SUCCESS (34.072s) [484.424134] [121/133] (538s left) kms_async_flips (crc-atomic) [484.497858] Starting subtest: crc-atomic [484.899213] Starting dynamic subtest: pipe-A-eDP-1 [487.775989] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.876s) [488.159753] Starting dynamic subtest: pipe-B-eDP-1 [491.086839] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.935s) [491.464162] Starting dynamic subtest: pipe-C-eDP-1 [494.312880] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.856s) [494.680570] Starting dynamic subtest: pipe-D-eDP-1 [497.523274] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.850s) [497.525617] Subtest crc-atomic: SUCCESS (13.024s) [498.697547] [122/133] (524s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [498.784269] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [498.786534] Starting dynamic subtest: A-eDP1 [502.327820] Dynamic subtest A-eDP1: SUCCESS (3.545s) [502.337630] Starting dynamic subtest: B-eDP1 [505.542018] Dynamic subtest B-eDP1: SUCCESS (3.212s) [505.552058] Starting dynamic subtest: C-eDP1 [508.660096] Dynamic subtest C-eDP1: SUCCESS (3.115s) [508.669629] Starting dynamic subtest: D-eDP1 [511.764796] Dynamic subtest D-eDP1: SUCCESS (3.102s) [511.767108] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.982s) [512.556188] [123/133] (510s left) syncobj_eventfd (invalid-illegal-eventfd) [512.608738] Starting subtest: invalid-illegal-eventfd [512.610638] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [512.700370] [124/133] (510s left) kms_prop_blob (blob-prop-core) [512.765317] Starting subtest: blob-prop-core [512.767566] Subtest blob-prop-core: SUCCESS (0.000s) [512.867734] [125/133] (510s left) kms_async_flips (alternate-sync-async-flip-atomic) [512.931472] Starting subtest: alternate-sync-async-flip-atomic [513.305388] Starting dynamic subtest: pipe-A-eDP-1 [516.056312] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.751s) [516.424899] Starting dynamic subtest: pipe-B-eDP-1 [519.185355] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s) [519.565148] Starting dynamic subtest: pipe-C-eDP-1 [522.315871] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.761s) [522.685963] Starting dynamic subtest: pipe-D-eDP-1 [525.442201] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.764s) [525.444245] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.512s) [526.607395] [126/133] (496s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [526.691066] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [526.693291] Starting dynamic subtest: pipe-A-eDP-1 [526.775941] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s) [526.786606] Starting dynamic subtest: pipe-B-eDP-1 [527.887429] Dynamic subtest pipe-B-eDP-1: SKIP (1.109s) [527.891934] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.200s) [529.088087] [127/133] (494s left) gem_eio (wait-10ms) [529.305205] Starting subtest: wait-10ms [529.654143] Subtest wait-10ms: SUCCESS (0.349s) [529.772350] [128/133] (493s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [529.844780] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [534.074822] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.234s) [535.285002] [129/133] (487s left) gem_flink_basic (flink-lifetime) [535.346700] Starting subtest: flink-lifetime [535.349150] Subtest flink-lifetime: SUCCESS (0.002s) [535.444031] [130/133] (487s left) gem_exec_reloc (basic-write-wc-noreloc) [535.513974] Subtest basic-write-wc-noreloc: SKIP (0.000s) [535.597409] [131/133] (487s left) kms_vblank (wait-forked-hang) [535.668486] Starting subtest: wait-forked-hang [535.670828] Starting dynamic subtest: pipe-A-eDP-1 [562.488475] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.819s) [562.510654] Starting dynamic subtest: pipe-D-eDP-1 [588.518424] Dynamic subtest pipe-D-eDP-1: SUCCESS (26.026s) [588.520630] Subtest wait-forked-hang: SUCCESS (52.852s) [589.317908] [132/133] (434s left) kms_frontbuffer_tracking (basic) [589.393947] Starting subtest: basic [592.512706] Subtest basic: SUCCESS (3.123s) [592.642721] [133/133] (430s left) kms_addfb_basic (small-bo) [592.721358] Starting subtest: small-bo [592.723237] Subtest small-bo: SUCCESS (0.000s) [592.816299] Closing watchdogs results: parsing output: 0/ for test: gem_exec_nop results: parsing output: 1/ for test: kms_big_fb results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_plane_multiple results: parsing output: 4/ for test: perf_pmu results: parsing output: 5/ for test: kms_psr results: parsing output: 6/ for test: i915_suspend results: parsing output: 7/ for test: gem_exec_balancer results: parsing output: 8/ for test: kms_rotation_crc results: parsing output: 9/ for test: gem_exec_reloc results: parsing output: 10/ for test: kms_flip_scaled_crc results: parsing output: 11/ for test: kms_tiled_display results: parsing output: 12/ for test: gem_exec_fence results: parsing output: 13/ for test: gen7_exec_parse results: parsing output: 14/ for test: kms_plane results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_chamelium_hpd results: parsing output: 18/ for test: kms_pm_rpm results: parsing output: 19/ for test: kms_big_fb results: parsing output: 20/ for test: gem_pxp results: parsing output: 21/ for test: kms_atomic_interruptible results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_ccs results: parsing output: 24/ for test: gem_exec_fence results: parsing output: 25/ for test: syncobj_wait results: parsing output: 26/ for test: gem_ctx_engines results: parsing output: 27/ for test: gem_lmem_swapping results: parsing output: 28/ for test: kms_cursor_crc results: parsing output: 29/ for test: kms_getfb results: parsing output: 30/ for test: kms_cursor_legacy results: parsing output: 31/ for test: gem_render_copy results: parsing output: 32/ for test: kms_pipe_stress results: parsing output: 33/ for test: gem_exec_suspend results: parsing output: 34/ for test: i915_hangman results: parsing output: 35/ for test: perf results: parsing output: 36/ for test: gem_render_copy results: parsing output: 37/ for test: kms_cursor_legacy results: parsing output: 38/ for test: gem_softpin results: parsing output: 39/ for test: kms_invalid_mode results: parsing output: 40/ for test: kms_flip results: parsing output: 41/ for test: gem_wait results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_exec_fence results: parsing output: 44/ for test: kms_psr results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: sysfs_timeslice_duration results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_draw_crc results: parsing output: 49/ for test: kms_color results: parsing output: 50/ for test: kms_flip_scaled_crc results: parsing output: 51/ for test: gem_mmap_gtt results: parsing output: 52/ for test: kms_psr results: parsing output: 53/ for test: syncobj_timeline results: parsing output: 54/ for test: kms_pm_rpm results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_plane results: parsing output: 58/ for test: gem_exec_whisper results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_joiner results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: gem_bad_reloc results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: gem_mmap_offset results: parsing output: 67/ for test: gem_mmap_gtt results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_cursor_crc results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: perf_pmu results: parsing output: 72/ for test: syncobj_wait results: parsing output: 73/ for test: kms_big_fb results: parsing output: 74/ for test: api_intel_allocator results: parsing output: 75/ for test: gem_ctx_shared results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: perf results: parsing output: 79/ for test: kms_cursor_legacy results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: gem_pwrite_snooped results: parsing output: 82/ for test: kms_cursor_legacy results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: syncobj_wait results: parsing output: 85/ for test: kms_concurrent results: parsing output: 86/ for test: api_intel_bb results: parsing output: 87/ for test: kms_ccs results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: i915_drm_fdinfo results: parsing output: 90/ for test: kms_cursor_edge_walk results: parsing output: 91/ for test: gem_exec_reloc results: parsing output: 92/ for test: gem_exec_params results: parsing output: 93/ for test: kms_chamelium_edid results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: core_getversion results: parsing output: 96/ for test: kms_chamelium_color results: parsing output: 97/ for test: prime_mmap results: parsing output: 98/ for test: gem_ctx_persistence results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_flip results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: kms_psr2_sf results: parsing output: 103/ for test: gen7_exec_parse results: parsing output: 104/ for test: gem_exec_reloc results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_pwrite_crc results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: gem_ctx_isolation results: parsing output: 109/ for test: gem_ctx_param results: parsing output: 110/ for test: kms_plane_scaling results: parsing output: 111/ for test: kms_big_fb results: parsing output: 112/ for test: sw_sync results: parsing output: 113/ for test: i915_pm_rpm results: parsing output: 114/ for test: gem_exec_schedule results: parsing output: 115/ for test: kms_ccs results: parsing output: 116/ for test: kms_ccs results: parsing output: 117/ for test: kms_addfb_basic results: parsing output: 118/ for test: kms_flip results: parsing output: 119/ for test: gem_exec_schedule results: parsing output: 120/ for test: kms_async_flips results: parsing output: 121/ for test: kms_flip results: parsing output: 122/ for test: syncobj_eventfd results: parsing output: 123/ for test: kms_prop_blob results: parsing output: 124/ for test: kms_async_flips results: parsing output: 125/ for test: kms_psr2_sf results: parsing output: 126/ for test: gem_eio results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_flink_basic results: parsing output: 129/ for test: gem_exec_reloc results: parsing output: 130/ for test: kms_vblank results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_addfb_basic Done.