[59.006949] Initializing watchdogs [59.007122] /dev/watchdog0 [59.021437] [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] [59.025783] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.027932] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.030850] [001/133] (960s left) gem_exec_nop (basic-sequential) [59.131866] Starting subtest: basic-sequential [73.403535] Subtest basic-sequential: SUCCESS (14.281s) [73.620577] [002/133] (945s left) kms_big_fb (y-tiled-32bpp-rotate-90) [73.715977] Starting subtest: y-tiled-32bpp-rotate-90 [73.720709] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [73.805106] [003/133] (945s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [73.914599] Starting subtest: fbc-rgb101010-draw-render [78.498621] Subtest fbc-rgb101010-draw-render: SUCCESS (4.589s) [79.689609] [004/133] (939s left) kms_plane_multiple (2x-tiling-4) [79.774271] Starting subtest: 2x-tiling-4 [79.778666] Subtest 2x-tiling-4: SKIP (0.000s) [79.840940] [005/133] (939s left) perf_pmu (semaphore-busy) [79.882783] Starting subtest: semaphore-busy [79.884872] Starting dynamic subtest: rcs0 [81.526278] Dynamic subtest rcs0: SUCCESS (1.641s) [81.536364] Starting dynamic subtest: bcs0 [83.158915] Dynamic subtest bcs0: SUCCESS (1.630s) [83.167909] Starting dynamic subtest: vcs0 [87.441069] Dynamic subtest vcs0: SUCCESS (4.280s) [87.451090] Starting dynamic subtest: vcs1 [92.432571] Dynamic subtest vcs1: SUCCESS (4.989s) [92.440781] Starting dynamic subtest: vecs0 [98.448572] Dynamic subtest vecs0: SUCCESS (6.014s) [98.457542] Starting dynamic subtest: ccs0 [101.523760] Dynamic subtest ccs0: SUCCESS (3.074s) [101.526443] Subtest semaphore-busy: SUCCESS (21.636s) [101.633864] [006/133] (918s left) kms_psr (psr2-primary-page-flip) [101.740798] Starting subtest: psr2-primary-page-flip [101.743043] Starting dynamic subtest: eDP-1 [103.468849] Dynamic subtest eDP-1: SUCCESS (1.728s) [103.471165] Subtest psr2-primary-page-flip: SUCCESS (1.729s) [104.338172] [007/133] (915s left) i915_suspend (fence-restore-tiled2untiled) [104.391365] Starting subtest: fence-restore-tiled2untiled [104.395934] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [104.494852] [008/133] (915s left) gem_exec_balancer (busy) [104.555827] Starting subtest: busy [105.934658] Subtest busy: SUCCESS (1.376s) [106.241071] [009/133] (913s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [106.343756] Starting subtest: primary-yf-tiled-reflect-x-180 [106.417128] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.073s) [106.516671] [010/133] (913s left) gem_exec_reloc (basic-wc-gtt-noreloc) [106.591738] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [106.667526] [011/133] (913s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [106.756935] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [106.759298] Starting dynamic subtest: pipe-A-default-mode [107.923267] Dynamic subtest pipe-A-default-mode: SKIP (1.164s) [107.927640] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.165s) [108.072204] [012/133] (911s left) kms_tiled_display (basic-test-pattern-with-chamelium) [108.186458] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s) [108.237827] [013/133] (911s left) gem_exec_fence (syncobj-timeline-export) [108.793382] Starting subtest: syncobj-timeline-export [108.799618] Subtest syncobj-timeline-export: SUCCESS (0.008s) [109.962425] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true [109.965853] [014/133] (910s left) gen7_exec_parse (bitmasks) [110.030160] Subtest bitmasks: SKIP (0.000s) [110.092890] [015/133] (909s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [110.187236] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [110.213195] Starting dynamic subtest: pipe-A-plane-0 [110.857684] Dynamic subtest pipe-A-plane-0: SUCCESS (0.645s) [110.869029] Starting dynamic subtest: pipe-A-plane-3 [111.257208] Dynamic subtest pipe-A-plane-3: SUCCESS (0.399s) [112.363674] Starting dynamic subtest: pipe-B-plane-0 [113.035983] Dynamic subtest pipe-B-plane-0: SUCCESS (0.678s) [113.045360] Starting dynamic subtest: pipe-B-plane-3 [113.446546] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s) [113.764421] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.579s) [114.625712] [016/133] (905s left) syncobj_timeline (single-wait-for-submit-available-signaled) [114.689917] Starting subtest: single-wait-for-submit-available-signaled [114.692421] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [114.802883] [017/133] (905s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [114.895702] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [114.899842] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [114.998528] [018/133] (905s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode) [115.391420] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s) [116.241559] [019/133] (903s left) kms_pm_rpm (dpms-mode-unset-lpsp) [118.097459] Starting subtest: dpms-mode-unset-lpsp [122.132957] Subtest dpms-mode-unset-lpsp: SUCCESS (4.039s) [122.522936] [020/133] (897s left) kms_big_fb (yf-tiled-addfb) [122.625877] Starting subtest: yf-tiled-addfb [122.630084] Subtest yf-tiled-addfb: SKIP (0.000s) [122.708743] [021/133] (897s left) gem_pxp (fail-invalid-protected-context) [122.830750] Starting subtest: fail-invalid-protected-context [122.833285] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [122.951848] [022/133] (897s left) kms_atomic_interruptible (legacy-cursor) [123.044090] Starting subtest: legacy-cursor [123.046463] Starting dynamic subtest: pipe-A-eDP-1 [130.424089] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.381s) [130.426438] Subtest legacy-cursor: SUCCESS (7.382s) [131.273410] [023/133] (889s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [131.366038] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [131.370194] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [131.464196] [024/133] (888s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [131.549814] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [131.552079] Starting dynamic subtest: pipe-A-eDP-1 [131.574143] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [131.582116] Starting dynamic subtest: pipe-B-eDP-1 [131.603681] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [131.611426] Starting dynamic subtest: pipe-C-eDP-1 [131.632718] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [131.640096] Starting dynamic subtest: pipe-D-eDP-1 [131.661681] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [131.666028] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s) [133.726144] [025/133] (886s left) gem_exec_fence (expired-history) [134.146709] Starting subtest: expired-history [141.591506] Subtest expired-history: SUCCESS (7.445s) [142.188259] [026/133] (878s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [142.252266] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [142.354420] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s) [142.443178] [027/133] (878s left) gem_ctx_engines (execute-allforone) [142.501363] Starting subtest: execute-allforone [142.529407] Subtest execute-allforone: SUCCESS (0.028s) [143.971428] [028/133] (876s left) gem_lmem_swapping (heavy-random) [144.013054] Subtest heavy-random: SKIP (0.000s) [144.050294] [029/133] (876s left) kms_cursor_crc (cursor-rapid-movement-512x512) [144.322600] Starting subtest: cursor-rapid-movement-512x512 [144.326849] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [144.500258] [030/133] (876s left) kms_getfb (getfb2-accept-nv12) [144.592261] Starting subtest: getfb2-accept-nv12 [144.594324] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [144.679801] [031/133] (876s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [144.795726] Starting subtest: basic-flip-before-cursor-atomic [145.722738] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.929s) [146.568923] [032/133] (874s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [146.635293] Starting subtest: x-tiled-to-vebox-yf-tiled [146.639765] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [146.817594] [033/133] (873s left) kms_pipe_stress (stress-xrgb8888-4tiled) [146.913795] Starting subtest: stress-xrgb8888-4tiled [152.791386] Subtest stress-xrgb8888-4tiled: SUCCESS (5.877s) [152.841057] [034/133] (867s left) gem_exec_suspend (basic) [152.908378] Starting subtest: basic [152.910315] Starting dynamic subtest: smem [154.902755] Dynamic subtest smem: SUCCESS (1.991s) [154.905596] Subtest basic: SUCCESS (1.993s) [155.087653] [035/133] (865s left) i915_hangman (engine-engine-error) [155.157595] Starting subtest: engine-engine-error [155.159549] Starting dynamic subtest: rcs0 [156.851680] Dynamic subtest rcs0: SUCCESS (1.693s) [156.860607] Starting dynamic subtest: bcs0 [158.836884] Dynamic subtest bcs0: SUCCESS (1.983s) [158.848072] Starting dynamic subtest: vcs0 [160.883460] Dynamic subtest vcs0: SUCCESS (2.044s) [160.896454] Starting dynamic subtest: vcs1 [162.868380] Dynamic subtest vcs1: SUCCESS (1.983s) [162.883023] Starting dynamic subtest: vecs0 [164.851457] Dynamic subtest vecs0: SUCCESS (1.982s) [164.865730] Starting dynamic subtest: ccs0 [166.837080] Dynamic subtest ccs0: SUCCESS (1.983s) [166.840331] Subtest engine-engine-error: SUCCESS (11.679s) [166.968060] [036/133] (853s left) perf (oa-formats) [167.089054] Starting subtest: oa-formats [167.091368] Starting dynamic subtest: 0-rcs0 [167.102555] Dynamic subtest 0-rcs0: SUCCESS (0.014s) [167.111338] Starting dynamic subtest: 1-vcs1 [167.124047] Dynamic subtest 1-vcs1: SUCCESS (0.021s) [167.126301] Subtest oa-formats: SUCCESS (0.036s) [167.172750] [037/133] (853s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [167.226088] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [167.230387] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [167.412319] [038/133] (853s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [167.542047] Starting subtest: cursorA-vs-flipB-toggle [167.546405] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [167.687362] [039/133] (853s left) gem_softpin (zero) [167.744104] Starting subtest: zero [167.748555] Subtest zero: SUCCESS (0.004s) [167.895897] [040/133] (853s left) kms_invalid_mode (bad-hsync-start) [167.989289] Starting subtest: bad-hsync-start [167.991637] Starting dynamic subtest: pipe-A-eDP-1 [168.283716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s) [168.293292] Starting dynamic subtest: pipe-B-eDP-1 [168.295493] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [168.303080] Starting dynamic subtest: pipe-C-eDP-1 [168.305352] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [168.312745] Starting dynamic subtest: pipe-D-eDP-1 [168.314702] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [168.316694] Subtest bad-hsync-start: SUCCESS (0.299s) [169.094061] [041/133] (852s left) kms_flip (modeset-vs-vblank-race) [169.198562] Starting subtest: modeset-vs-vblank-race [169.201024] Starting dynamic subtest: A-eDP1 [173.897184] Dynamic subtest A-eDP1: SUCCESS (4.701s) [173.908060] Starting dynamic subtest: B-eDP1 [178.619321] Dynamic subtest B-eDP1: SUCCESS (4.720s) [178.629663] Starting dynamic subtest: C-eDP1 [183.221683] Dynamic subtest C-eDP1: SUCCESS (4.600s) [183.232825] Starting dynamic subtest: D-eDP1 [187.774565] Dynamic subtest D-eDP1: SUCCESS (4.551s) [187.776994] Subtest modeset-vs-vblank-race: SUCCESS (18.582s) [188.941837] [042/133] (832s left) gem_wait (invalid-flags) [189.006714] Starting subtest: invalid-flags [189.008982] Subtest invalid-flags: SUCCESS (0.000s) [189.219010] [043/133] (831s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [189.326379] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [193.601737] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.278s) [194.746351] [044/133] (826s left) gem_exec_fence (syncobj-timeline-signal) [195.307601] Starting subtest: syncobj-timeline-signal [195.313919] Subtest syncobj-timeline-signal: SUCCESS (0.008s) [196.967701] [045/133] (824s left) kms_psr (pr-cursor-plane-move) [197.061889] Starting subtest: pr-cursor-plane-move [197.066286] Subtest pr-cursor-plane-move: SKIP (0.000s) [197.134026] [046/133] (824s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [197.230745] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [197.235189] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [197.340060] [047/133] (824s left) sysfs_timeslice_duration (idempotent) [197.406842] Starting subtest: idempotent [197.409274] Starting dynamic subtest: vecs0 [197.411521] Dynamic subtest vecs0: SUCCESS (0.000s) [197.421137] Starting dynamic subtest: ccs0 [197.423264] Dynamic subtest ccs0: SUCCESS (0.000s) [197.430791] Starting dynamic subtest: vcs0 [197.433017] Dynamic subtest vcs0: SUCCESS (0.000s) [197.440770] Starting dynamic subtest: bcs0 [197.443039] Dynamic subtest bcs0: SUCCESS (0.000s) [197.450585] Starting dynamic subtest: rcs0 [197.452469] Dynamic subtest rcs0: SUCCESS (0.000s) [197.460198] Starting dynamic subtest: vcs1 [197.462421] Dynamic subtest vcs1: SUCCESS (0.000s) [197.464633] Subtest idempotent: SUCCESS (0.005s) [197.505900] [048/133] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [197.600580] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [197.604995] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [197.684130] [049/133] (823s left) kms_draw_crc (draw-method-blt) [197.775271] Starting subtest: draw-method-blt [197.777488] Starting dynamic subtest: xrgb8888-untiled [198.041777] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s) [198.049984] Starting dynamic subtest: rgb565-untiled [198.262689] Dynamic subtest rgb565-untiled: SUCCESS (0.222s) [198.273323] Starting dynamic subtest: xrgb2101010-untiled [198.485841] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [198.494132] Starting dynamic subtest: xbgr16161616f-untiled [198.729139] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.243s) [198.736843] Starting dynamic subtest: xrgb8888-xtiled [198.851308] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s) [198.859020] Starting dynamic subtest: rgb565-xtiled [198.962490] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s) [198.972041] Starting dynamic subtest: xrgb2101010-xtiled [199.074032] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.109s) [199.084193] Starting dynamic subtest: xbgr16161616f-xtiled [199.184570] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s) [199.192188] Starting dynamic subtest: xrgb8888-4tiled [199.306952] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s) [199.316853] Starting dynamic subtest: rgb565-4tiled [199.429963] Dynamic subtest rgb565-4tiled: SUCCESS (0.120s) [199.437981] Starting dynamic subtest: xrgb2101010-4tiled [199.529045] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.097s) [199.536729] Starting dynamic subtest: xbgr16161616f-4tiled [199.628915] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.099s) [199.630809] Subtest draw-method-blt: SUCCESS (1.856s) [199.748960] [050/133] (821s left) kms_color (deep-color) [199.831092] Starting subtest: deep-color [200.911110] Starting dynamic subtest: pipe-A-eDP-1-gamma [201.606701] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.694s) [201.615184] Starting dynamic subtest: pipe-A-eDP-1-degamma [203.025805] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.419s) [203.033735] Starting dynamic subtest: pipe-A-eDP-1-ctm [204.442554] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.418s) [205.219061] Starting dynamic subtest: pipe-B-eDP-1-gamma [205.941227] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.726s) [205.950047] Starting dynamic subtest: pipe-B-eDP-1-degamma [207.390877] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.450s) [207.399702] Starting dynamic subtest: pipe-B-eDP-1-ctm [208.837711] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.446s) [209.609408] Starting dynamic subtest: pipe-C-eDP-1-gamma [210.282818] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.682s) [210.291833] Starting dynamic subtest: pipe-C-eDP-1-degamma [211.655124] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.369s) [211.664945] Starting dynamic subtest: pipe-C-eDP-1-ctm [213.053877] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.397s) [213.883048] Starting dynamic subtest: pipe-D-eDP-1-gamma [214.584277] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.708s) [214.592687] Starting dynamic subtest: pipe-D-eDP-1-degamma [216.025844] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.441s) [216.036750] Starting dynamic subtest: pipe-D-eDP-1-ctm [217.447830] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.421s) [217.450564] Subtest deep-color: SUCCESS (17.617s) [218.312294] [051/133] (803s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [218.425411] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [218.429820] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s) [218.507068] [052/133] (803s left) gem_mmap_gtt (medium-copy) [218.564788] Subtest medium-copy: SKIP (0.000s) [218.619167] [053/133] (802s left) kms_psr (psr-dpms) [218.720320] Starting subtest: psr-dpms [218.722629] Starting dynamic subtest: eDP-1 [221.655910] Dynamic subtest eDP-1: SUCCESS (2.937s) [221.658575] Subtest psr-dpms: SUCCESS (2.938s) [222.508839] [054/133] (799s left) syncobj_timeline (invalid-wait-illegal-handle) [222.568408] Starting subtest: invalid-wait-illegal-handle [222.570376] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [222.666093] [055/133] (799s left) kms_pm_rpm (system-suspend-idle) [224.186228] Starting subtest: system-suspend-idle [243.843740] Subtest system-suspend-idle: SUCCESS (4.425s) [244.224213] [056/133] (777s left) kms_big_fb (4-tiled-addfb-size-overflow) [244.332924] Starting subtest: 4-tiled-addfb-size-overflow [244.335266] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [244.425745] [057/133] (777s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [244.529541] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [251.533738] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.001s) [251.670438] [058/133] (770s left) kms_plane (plane-position-covered) [251.765381] Starting subtest: plane-position-covered [252.293393] Starting dynamic subtest: pipe-A-plane-1 [253.658278] Dynamic subtest pipe-A-plane-1: SUCCESS (1.363s) [253.667402] Starting dynamic subtest: pipe-A-plane-2 [254.941696] Dynamic subtest pipe-A-plane-2: SUCCESS (1.280s) [254.950312] Starting dynamic subtest: pipe-A-plane-3 [256.172987] Dynamic subtest pipe-A-plane-3: SUCCESS (1.232s) [256.183145] Starting dynamic subtest: pipe-A-plane-4 [257.433167] Dynamic subtest pipe-A-plane-4: SUCCESS (1.258s) [257.441761] Starting dynamic subtest: pipe-A-plane-5 [257.457421] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s) [258.669613] Starting dynamic subtest: pipe-B-plane-1 [260.037970] Dynamic subtest pipe-B-plane-1: SUCCESS (1.378s) [260.048197] Starting dynamic subtest: pipe-B-plane-2 [261.304546] Dynamic subtest pipe-B-plane-2: SUCCESS (1.265s) [261.314387] Starting dynamic subtest: pipe-B-plane-3 [262.543584] Dynamic subtest pipe-B-plane-3: SUCCESS (1.236s) [262.552880] Starting dynamic subtest: pipe-B-plane-4 [263.790208] Dynamic subtest pipe-B-plane-4: SUCCESS (1.248s) [263.799940] Starting dynamic subtest: pipe-B-plane-5 [263.817688] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s) [263.820051] Subtest plane-position-covered: SUCCESS (12.049s) [264.653081] [059/133] (757s left) gem_exec_whisper (basic-contexts-all) [264.721698] Starting subtest: basic-contexts-all [275.550144] Subtest basic-contexts-all: SUCCESS (10.822s) [275.747383] [060/133] (746s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [275.849943] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [275.854255] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [275.936245] [061/133] (746s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [276.032615] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [276.036818] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [276.150461] [062/133] (745s left) kms_joiner (invalid-modeset-ultra-joiner) [276.251198] Starting subtest: invalid-modeset-ultra-joiner [276.255700] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [276.320133] [063/133] (745s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [276.421834] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt [276.425873] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [276.518212] [064/133] (745s left) gem_bad_reloc (negative-reloc-lut) [276.587254] Subtest negative-reloc-lut: SKIP (0.000s) [276.665257] [065/133] (745s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [276.761691] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [276.765273] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [276.845540] [066/133] (745s left) syncobj_timeline (multi-wait-for-submit-signaled) [276.895594] Starting subtest: multi-wait-for-submit-signaled [276.897275] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s) [276.984265] [067/133] (745s left) gem_mmap_offset (partial-remap) [277.036324] Starting subtest: partial-remap [277.038280] Starting dynamic subtest: smem0 [277.048449] Dynamic subtest smem0: SUCCESS (0.005s) [277.050033] Subtest partial-remap: SUCCESS (0.006s) [277.183152] [068/133] (745s left) gem_mmap_gtt (cpuset-basic-small-copy) [277.245445] Subtest cpuset-basic-small-copy: SKIP (0.000s) [277.301949] [069/133] (744s left) kms_frontbuffer_tracking (fbc-tiling-4) [277.405657] Starting subtest: fbc-tiling-4 [281.570920] Subtest fbc-tiling-4: SUCCESS (4.166s) [282.793492] [070/133] (739s left) kms_cursor_crc (cursor-offscreen-32x10) [282.944149] Starting subtest: cursor-offscreen-32x10 [282.990997] Subtest cursor-offscreen-32x10: SKIP (0.041s) [283.384480] [071/133] (738s left) kms_psr (fbc-psr2-primary-mmap-cpu) [283.468517] Starting subtest: fbc-psr2-primary-mmap-cpu [283.470412] Starting dynamic subtest: eDP-1 [283.474475] Dynamic subtest eDP-1: SKIP (0.000s) [283.478632] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s) [283.542337] [072/133] (738s left) perf_pmu (idle) [283.589156] Starting subtest: idle [283.591385] Starting dynamic subtest: rcs0 [284.128964] Dynamic subtest rcs0: SUCCESS (0.541s) [284.140666] Starting dynamic subtest: bcs0 [284.644913] Dynamic subtest bcs0: SUCCESS (0.513s) [284.656747] Starting dynamic subtest: vcs0 [285.166701] Dynamic subtest vcs0: SUCCESS (0.515s) [285.177002] Starting dynamic subtest: vcs1 [285.690263] Dynamic subtest vcs1: SUCCESS (0.525s) [285.702050] Starting dynamic subtest: vecs0 [286.210914] Dynamic subtest vecs0: SUCCESS (0.517s) [286.222985] Starting dynamic subtest: ccs0 [286.733662] Dynamic subtest ccs0: SUCCESS (0.520s) [286.736856] Subtest idle: SUCCESS (3.147s) [286.847015] [073/133] (735s left) syncobj_wait (single-wait-all-for-submit-signaled) [286.909537] Starting subtest: single-wait-all-for-submit-signaled [286.911887] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [287.022407] [074/133] (735s left) kms_big_fb (x-tiled-64bpp-rotate-90) [287.120038] Starting subtest: x-tiled-64bpp-rotate-90 [287.139420] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [287.256336] [075/133] (735s left) api_intel_allocator (default-alignment) [287.322284] Starting subtest: default-alignment [287.324960] Subtest default-alignment: SUCCESS (0.004s) [287.447366] [076/133] (735s left) gem_ctx_shared (q-out-order) [287.502668] Starting subtest: Q-out-order [287.504803] Starting dynamic subtest: rcs0 [287.634534] Dynamic subtest rcs0: SUCCESS (0.130s) [287.646962] Starting dynamic subtest: vcs0 [287.726854] Dynamic subtest vcs0: SUCCESS (0.092s) [287.743617] Starting dynamic subtest: vcs1 [287.813210] Dynamic subtest vcs1: SUCCESS (0.085s) [287.831765] Starting dynamic subtest: vecs0 [287.890040] Dynamic subtest vecs0: SUCCESS (0.076s) [287.906405] Starting dynamic subtest: ccs0 [287.968943] Dynamic subtest ccs0: SUCCESS (0.078s) [287.971443] Subtest Q-out-order: SUCCESS (0.466s) [289.203171] [077/133] (733s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [289.295127] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [289.299602] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [289.386632] [078/133] (733s left) syncobj_timeline (etime-multi-wait-all-submitted) [289.453027] Starting subtest: etime-multi-wait-all-submitted [289.563713] Subtest etime-multi-wait-all-submitted: SUCCESS (0.109s) [289.641109] [079/133] (733s left) perf (gen12-invalid-class-instance) [289.743062] Starting subtest: gen12-invalid-class-instance [289.755048] Subtest gen12-invalid-class-instance: SUCCESS (0.009s) [289.793790] [080/133] (732s left) kms_cursor_legacy (single-move) [289.906445] Starting subtest: single-move [289.908527] Starting dynamic subtest: pipe-A [295.290841] Dynamic subtest pipe-A: SUCCESS (5.380s) [295.301585] Starting dynamic subtest: pipe-B [300.675504] Dynamic subtest pipe-B: SUCCESS (5.379s) [300.686737] Starting dynamic subtest: pipe-C [306.056975] Dynamic subtest pipe-C: SUCCESS (5.379s) [306.068048] Starting dynamic subtest: pipe-D [311.440699] Dynamic subtest pipe-D: SUCCESS (5.379s) [311.451924] Starting dynamic subtest: all-pipes [316.830151] Dynamic subtest all-pipes: SUCCESS (5.386s) [316.832650] Subtest single-move: SUCCESS (26.918s) [316.977532] [081/133] (705s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [317.068154] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [325.525140] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.459s) [325.645025] [082/133] (697s left) gem_pwrite_snooped [325.769990] [083/133] (697s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [325.879036] Starting subtest: cursorB-vs-flipB-toggle [325.883673] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [326.020510] [084/133] (696s left) gem_mmap_gtt (basic-write-read-distinct) [326.077264] Subtest basic-write-read-distinct: SKIP (0.000s) [326.147704] [085/133] (696s left) syncobj_wait (reset-multiple-signaled) [326.195202] Starting subtest: reset-multiple-signaled [326.197487] Subtest reset-multiple-signaled: SUCCESS (0.000s) [326.290016] [086/133] (696s left) kms_concurrent (multi-plane-atomic-lowres) [326.379469] Starting subtest: multi-plane-atomic-lowres [326.381747] Starting dynamic subtest: pipe-A-eDP-1 [326.906386] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.524s) [326.915552] Starting dynamic subtest: pipe-B-eDP-1 [328.124711] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.218s) [328.134432] Starting dynamic subtest: pipe-C-eDP-1 [329.367775] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.241s) [329.377694] Starting dynamic subtest: pipe-D-eDP-1 [330.574576] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.204s) [330.576834] Subtest multi-plane-atomic-lowres: SUCCESS (4.193s) [331.421837] [087/133] (691s left) api_intel_bb (object-noreloc-keep-cache-simple) [331.476731] Starting subtest: object-noreloc-keep-cache-simple [331.479198] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s) [331.594313] [088/133] (691s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [331.680290] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [331.682658] Starting dynamic subtest: pipe-A-eDP-1 [331.706085] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [331.717565] Starting dynamic subtest: pipe-B-eDP-1 [331.739558] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [331.748601] Starting dynamic subtest: pipe-C-eDP-1 [331.770690] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [331.780266] Starting dynamic subtest: pipe-D-eDP-1 [331.801983] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [331.806021] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s) [333.900485] [089/133] (689s left) kms_big_fb (linear-8bpp-rotate-90) [334.002321] Starting subtest: linear-8bpp-rotate-90 [334.022930] Subtest linear-8bpp-rotate-90: SKIP (0.020s) [334.135480] [090/133] (688s left) i915_drm_fdinfo (busy) [334.176744] Starting subtest: busy [334.179038] Starting dynamic subtest: rcs0 [334.197154] Dynamic subtest rcs0: SKIP (0.018s) [334.206303] Starting dynamic subtest: bcs0 [334.210551] Dynamic subtest bcs0: SKIP (0.001s) [334.219611] Starting dynamic subtest: vcs0 [334.223685] Dynamic subtest vcs0: SKIP (0.000s) [334.232268] Starting dynamic subtest: vcs1 [334.236610] Dynamic subtest vcs1: SKIP (0.000s) [334.245116] Starting dynamic subtest: vecs0 [334.249400] Dynamic subtest vecs0: SKIP (0.000s) [334.258007] Starting dynamic subtest: ccs0 [334.262313] Dynamic subtest ccs0: SKIP (0.000s) [334.266645] Subtest busy: SKIP (0.024s) [334.302852] [091/133] (688s left) kms_cursor_edge_walk (64x64-right-edge) [334.393105] Starting subtest: 64x64-right-edge [334.395427] Starting dynamic subtest: pipe-A-eDP-1 [337.862575] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s) [337.874661] Starting dynamic subtest: pipe-D-eDP-1 [340.986421] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s) [340.988818] Subtest 64x64-right-edge: SUCCESS (6.594s) [341.805245] [092/133] (681s left) gem_exec_reloc (basic-cpu-gtt-active) [341.875189] Subtest basic-cpu-gtt-active: SKIP (0.000s) [341.949818] [093/133] (681s left) gem_exec_params (batch-first) [342.006463] Starting subtest: batch-first [342.009077] Subtest batch-first: SUCCESS (0.005s) [342.128063] [094/133] (681s left) kms_chamelium_edid (dp-edid-change-during-suspend) [342.508346] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [343.302959] [095/133] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [343.398537] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [343.402534] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [343.492012] [096/133] (679s left) core_getversion (basic) [343.529014] Starting subtest: basic [343.533543] Subtest basic: SUCCESS (0.000s) [343.604740] [097/133] (679s left) kms_chamelium_color (ctm-max) [343.700692] Subtest ctm-max: SKIP (0.000s) [343.747869] [098/133] (679s left) prime_mmap (test_userptr) [343.799067] Starting subtest: test_userptr [343.801328] Starting dynamic subtest: test_userptr-smem [343.803460] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [343.805559] Subtest test_userptr: SUCCESS (0.001s) [343.887213] [099/133] (679s left) gem_ctx_persistence (userptr) [343.944413] Starting subtest: userptr [344.131858] Subtest userptr: SUCCESS (0.190s) [344.211139] [100/133] (679s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [344.313287] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [344.316566] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [344.419011] [101/133] (679s left) kms_flip (flip-vs-panning-interruptible) [344.513567] Starting subtest: flip-vs-panning-interruptible [344.515393] Starting dynamic subtest: A-eDP1 [353.239540] Dynamic subtest A-eDP1: SUCCESS (8.725s) [353.251494] Starting dynamic subtest: B-eDP1 [361.976492] Dynamic subtest B-eDP1: SUCCESS (8.735s) [361.985557] Starting dynamic subtest: C-eDP1 [370.701646] Dynamic subtest C-eDP1: SUCCESS (8.724s) [370.713941] Starting dynamic subtest: D-eDP1 [379.426641] Dynamic subtest D-eDP1: SUCCESS (8.724s) [379.431446] Subtest flip-vs-panning-interruptible: SUCCESS (34.918s) [380.587465] [102/133] (643s left) kms_flip (plain-flip-fb-recreate) [380.692730] Starting subtest: plain-flip-fb-recreate [380.695047] Starting dynamic subtest: A-eDP1 [389.593786] Dynamic subtest A-eDP1: SUCCESS (8.903s) [389.605259] Starting dynamic subtest: B-eDP1 [398.413300] Dynamic subtest B-eDP1: SUCCESS (8.817s) [398.423485] Starting dynamic subtest: C-eDP1 [407.229109] Dynamic subtest C-eDP1: SUCCESS (8.814s) [407.237543] Starting dynamic subtest: D-eDP1 [416.060635] Dynamic subtest D-eDP1: SUCCESS (8.830s) [416.065716] Subtest plain-flip-fb-recreate: SUCCESS (35.373s) [417.246808] [103/133] (606s left) kms_psr2_sf (psr2-cursor-plane-update-sf) [417.353595] Starting subtest: psr2-cursor-plane-update-sf [417.355981] Starting dynamic subtest: pipe-A-eDP-1 [417.906615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.559s) [417.916639] Starting dynamic subtest: pipe-B-eDP-1 [419.227711] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.320s) [419.230010] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.881s) [420.100978] [104/133] (603s left) gen7_exec_parse (basic-allowed) [420.161756] Subtest basic-allowed: SKIP (0.000s) [420.238078] [105/133] (603s left) gem_exec_reloc (basic-wc-gtt) [420.302987] Subtest basic-wc-gtt: SKIP (0.000s) [420.367957] [106/133] (603s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [420.458478] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [420.462444] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [420.561176] [107/133] (603s left) kms_pwrite_crc [422.143254] [108/133] (601s left) kms_psr (fbc-psr-primary-mmap-gtt) [422.234453] Starting subtest: fbc-psr-primary-mmap-gtt [422.236733] Starting dynamic subtest: eDP-1 [422.240904] Dynamic subtest eDP-1: SKIP (0.000s) [422.245137] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s) [422.312903] [109/133] (601s left) gem_ctx_isolation (dirty-switch) [422.372477] Starting subtest: dirty-switch [422.374722] Starting dynamic subtest: rcs0 [422.555487] Dynamic subtest rcs0: SUCCESS (0.183s) [422.564211] Starting dynamic subtest: bcs0 [422.759661] Dynamic subtest bcs0: SUCCESS (0.203s) [422.770283] Starting dynamic subtest: vcs0 [422.952788] Dynamic subtest vcs0: SUCCESS (0.192s) [422.962517] Starting dynamic subtest: vcs1 [424.319785] Dynamic subtest vcs1: SUCCESS (1.366s) [424.330882] Starting dynamic subtest: vecs0 [426.346035] Dynamic subtest vecs0: SUCCESS (2.025s) [426.355863] Starting dynamic subtest: ccs0 [428.334933] Dynamic subtest ccs0: SUCCESS (1.988s) [428.337525] Subtest dirty-switch: SUCCESS (5.962s) [428.575632] [110/133] (595s left) gem_ctx_param (set-priority-not-supported) [428.644717] Starting subtest: set-priority-not-supported [428.649066] Subtest set-priority-not-supported: SKIP (0.000s) [428.718864] [111/133] (595s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [428.812941] Starting subtest: plane-upscale-factor-0-25-with-rotation [428.815074] Starting dynamic subtest: pipe-A [429.037562] Dynamic subtest pipe-A: SUCCESS (0.227s) [429.046752] Starting dynamic subtest: pipe-B [430.337497] Dynamic subtest pipe-B: SUCCESS (1.299s) [430.346879] Starting dynamic subtest: pipe-C [431.658992] Dynamic subtest pipe-C: SUCCESS (1.320s) [431.674352] Starting dynamic subtest: pipe-D [432.989099] Dynamic subtest pipe-D: SUCCESS (1.328s) [432.991352] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.179s) [434.185071] [112/133] (589s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [434.282836] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [435.384634] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.101s) [435.495842] [113/133] (588s left) sw_sync (sync_busy) [435.533169] Starting subtest: sync_busy [435.535304] Subtest sync_busy: SUCCESS (0.002s) [435.590161] [114/133] (588s left) i915_pm_rpm (debugfs-forcewake-user) [437.324314] Starting subtest: debugfs-forcewake-user [448.716062] Subtest debugfs-forcewake-user: SUCCESS (11.393s) [449.102120] [115/133] (575s left) gem_exec_schedule (u-semaphore-codependency) [449.170508] Starting subtest: u-semaphore-codependency [449.175185] Subtest u-semaphore-codependency: SUCCESS (0.012s) [449.507055] [116/133] (574s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [449.604243] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [449.608805] Starting dynamic subtest: pipe-A-eDP-1 [449.631097] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [449.642403] Starting dynamic subtest: pipe-B-eDP-1 [449.663360] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [449.672189] Starting dynamic subtest: pipe-C-eDP-1 [449.693675] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [449.702565] Starting dynamic subtest: pipe-D-eDP-1 [449.724353] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [449.728634] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s) [451.762725] [117/133] (572s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [451.855418] Starting subtest: bad-rotation-90-yf-tiled-ccs [451.857649] Starting dynamic subtest: pipe-A-eDP-1 [451.880334] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [451.889855] Starting dynamic subtest: pipe-B-eDP-1 [451.911389] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [451.920455] Starting dynamic subtest: pipe-C-eDP-1 [451.941903] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [451.950648] Starting dynamic subtest: pipe-D-eDP-1 [451.972488] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [451.976432] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s) [454.120054] [118/133] (570s left) kms_addfb_basic (bad-pitch-256) [454.176771] Starting subtest: bad-pitch-256 [454.179029] Subtest bad-pitch-256: SUCCESS (0.000s) [454.332684] [119/133] (570s left) kms_flip (2x-flip-vs-modeset-vs-hang) [454.428269] Starting subtest: 2x-flip-vs-modeset-vs-hang [454.438742] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s) [454.554503] [120/133] (569s left) gem_exec_schedule (manyslice) [454.626785] Starting subtest: manyslice [454.628769] Starting dynamic subtest: rcs0 [459.752321] Dynamic subtest rcs0: SUCCESS (5.135s) [459.764457] Starting dynamic subtest: bcs0 [466.385237] Dynamic subtest bcs0: SUCCESS (6.629s) [466.399031] Starting dynamic subtest: vcs0 [471.977534] Dynamic subtest vcs0: SUCCESS (5.593s) [471.990890] Starting dynamic subtest: vcs1 [478.570643] Dynamic subtest vcs1: SUCCESS (6.591s) [478.584381] Starting dynamic subtest: vecs0 [484.658172] Dynamic subtest vecs0: SUCCESS (6.086s) [484.675059] Starting dynamic subtest: ccs0 [491.848938] Dynamic subtest ccs0: SUCCESS (7.189s) [491.851264] Subtest manyslice: SUCCESS (37.236s) [492.159574] [121/133] (532s left) kms_async_flips (crc-atomic) [492.260922] Starting subtest: crc-atomic [492.633970] Starting dynamic subtest: pipe-A-eDP-1 [495.531990] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.897s) [495.921196] Starting dynamic subtest: pipe-B-eDP-1 [498.889659] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.978s) [499.263265] Starting dynamic subtest: pipe-C-eDP-1 [502.177330] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.922s) [502.543056] Starting dynamic subtest: pipe-D-eDP-1 [505.402283] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.871s) [505.404653] Subtest crc-atomic: SUCCESS (13.143s) [506.585973] [122/133] (517s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [506.693863] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [506.696140] Starting dynamic subtest: A-eDP1 [510.315756] Dynamic subtest A-eDP1: SUCCESS (3.618s) [510.327791] Starting dynamic subtest: B-eDP1 [513.494174] Dynamic subtest B-eDP1: SUCCESS (3.179s) [513.503083] Starting dynamic subtest: C-eDP1 [516.597583] Dynamic subtest C-eDP1: SUCCESS (3.101s) [516.608285] Starting dynamic subtest: D-eDP1 [519.690598] Dynamic subtest D-eDP1: SUCCESS (3.090s) [519.692563] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.997s) [520.488790] [123/133] (504s left) syncobj_eventfd (invalid-illegal-eventfd) [520.541240] Starting subtest: invalid-illegal-eventfd [520.543605] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [520.625702] [124/133] (503s left) kms_prop_blob (blob-prop-core) [520.676910] Starting subtest: blob-prop-core [520.679292] Subtest blob-prop-core: SUCCESS (0.000s) [520.767234] [125/133] (503s left) kms_async_flips (alternate-sync-async-flip-atomic) [520.879387] Starting subtest: alternate-sync-async-flip-atomic [521.260325] Starting dynamic subtest: pipe-A-eDP-1 [524.088995] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.829s) [524.471280] Starting dynamic subtest: pipe-B-eDP-1 [527.223682] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.763s) [527.592378] Starting dynamic subtest: pipe-C-eDP-1 [530.345452] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.762s) [530.713079] Starting dynamic subtest: pipe-D-eDP-1 [533.483576] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s) [533.485801] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.607s) [534.643689] [126/133] (489s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [534.759788] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [534.762311] Starting dynamic subtest: pipe-A-eDP-1 [534.854652] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s) [534.864343] Starting dynamic subtest: pipe-B-eDP-1 [536.030376] Dynamic subtest pipe-B-eDP-1: SKIP (1.173s) [536.034995] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.275s) [537.209192] [127/133] (487s left) gem_eio (wait-10ms) [537.447772] Starting subtest: wait-10ms [537.821802] Subtest wait-10ms: SUCCESS (0.373s) [537.979533] [128/133] (486s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [538.082750] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [542.350421] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.271s) [543.513846] [129/133] (481s left) gem_flink_basic (flink-lifetime) [543.571783] Starting subtest: flink-lifetime [543.574200] Subtest flink-lifetime: SUCCESS (0.002s) [543.680517] [130/133] (481s left) gem_exec_reloc (basic-write-wc-noreloc) [543.760949] Subtest basic-write-wc-noreloc: SKIP (0.000s) [543.840289] [131/133] (481s left) kms_vblank (wait-forked-hang) [543.932324] Starting subtest: wait-forked-hang [543.934556] Starting dynamic subtest: pipe-A-eDP-1 [569.889266] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.954s) [569.903954] Starting dynamic subtest: pipe-D-eDP-1 [594.901590] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.007s) [594.903536] Subtest wait-forked-hang: SUCCESS (50.966s) [595.769878] [132/133] (429s left) kms_frontbuffer_tracking (basic) [595.878112] Starting subtest: basic [599.033276] Subtest basic: SUCCESS (3.159s) [599.154120] [133/133] (425s left) kms_addfb_basic (small-bo) [599.243424] Starting subtest: small-bo [599.244997] Subtest small-bo: SUCCESS (0.000s) [599.337529] 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.