[102.898498] Initializing watchdogs [102.898543] /dev/watchdog0 [102.912589] [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] [102.917228] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [102.919676] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [102.923019] [001/133] (960s left) kms_feature_discovery (display-2x) [103.046723] Starting subtest: display-2x [103.051240] Subtest display-2x: SKIP (0.000s) [103.130392] [002/133] (960s left) perf (polling) [103.274486] Starting subtest: polling [103.276689] Starting dynamic subtest: 0-rcs0 [113.296713] Dynamic subtest 0-rcs0: SUCCESS (10.021s) [113.303857] Starting dynamic subtest: 1-vecs0 [123.318352] Dynamic subtest 1-vecs0: SUCCESS (10.021s) [123.321102] Subtest polling: SUCCESS (20.043s) [123.364203] [003/133] (940s left) kms_content_protection (lic-type-1) [123.523404] Starting subtest: lic-type-1 [123.528123] Subtest lic-type-1: SKIP (0.000s) [123.671321] [004/133] (939s left) kms_flip (flip-vs-panning-vs-hang) [123.768808] Starting subtest: flip-vs-panning-vs-hang [123.770919] Starting dynamic subtest: A-eDP1 [163.396690] Dynamic subtest A-eDP1: SUCCESS (39.630s) [163.406576] Starting dynamic subtest: D-eDP1 [212.423760] Dynamic subtest D-eDP1: SUCCESS (49.019s) [212.428574] Subtest flip-vs-panning-vs-hang: SUCCESS (88.654s) [213.852828] [005/133] (849s left) gem_ctx_persistence (legacy-engines-queued) [213.910859] Starting subtest: legacy-engines-queued [213.913148] Starting dynamic subtest: render [213.977407] Dynamic subtest render: SUCCESS (0.066s) [213.987815] Starting dynamic subtest: bsd1 [215.865891] Dynamic subtest bsd1: SUCCESS (1.884s) [215.876074] Starting dynamic subtest: bsd2 [217.912044] Dynamic subtest bsd2: SUCCESS (2.044s) [217.924980] Starting dynamic subtest: blt [217.980685] Dynamic subtest blt: SUCCESS (0.069s) [217.990152] Starting dynamic subtest: vebox [219.895692] Dynamic subtest vebox: SUCCESS (1.911s) [219.898814] Subtest legacy-engines-queued: SUCCESS (5.983s) [219.973459] [006/133] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [220.086516] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [220.090798] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [220.177947] [007/133] (843s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [220.306272] Starting subtest: verify-pxp-stale-buf-optout-execution [221.368144] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.063s) [221.494336] [008/133] (842s left) gem_softpin (allocator-nopin) [221.549241] Starting subtest: allocator-nopin [221.648629] Subtest allocator-nopin: SUCCESS (0.099s) [221.777830] [009/133] (841s left) gem_ccs (suspend-resume) [221.835628] Starting subtest: suspend-resume [221.839992] Subtest suspend-resume: SKIP (0.000s) [221.926780] [010/133] (841s left) sysfs_timeslice_duration (duration) [221.985999] Starting subtest: duration [221.988297] Starting dynamic subtest: vecs0 [235.830902] Dynamic subtest vecs0: SUCCESS (13.842s) [235.842800] Starting dynamic subtest: ccs0 [248.974850] Dynamic subtest ccs0: SUCCESS (13.143s) [248.984877] Starting dynamic subtest: vcs0 [262.838718] Dynamic subtest vcs0: SUCCESS (13.860s) [262.849236] Starting dynamic subtest: bcs0 [275.971468] Dynamic subtest bcs0: SUCCESS (13.132s) [275.982590] Starting dynamic subtest: rcs0 [289.105171] Dynamic subtest rcs0: SUCCESS (13.132s) [289.115103] Starting dynamic subtest: vcs1 [302.839385] Dynamic subtest vcs1: SUCCESS (13.731s) [302.842345] Subtest duration: SUCCESS (80.849s) [302.924518] [011/133] (760s left) kms_psr (fbc-psr-cursor-mmap-gtt) [303.017938] Starting subtest: fbc-psr-cursor-mmap-gtt [303.020218] Starting dynamic subtest: eDP-1 [303.024596] Dynamic subtest eDP-1: SKIP (0.000s) [303.029058] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s) [303.087326] [012/133] (760s left) kms_busy (extended-pageflip-hang-oldfb) [303.185082] Starting subtest: extended-pageflip-hang-oldfb [303.187486] Starting dynamic subtest: pipe-A [303.632466] Dynamic subtest pipe-A: SUCCESS (0.447s) [303.641673] Starting dynamic subtest: pipe-D [304.760614] Dynamic subtest pipe-D: SUCCESS (1.126s) [304.762890] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.577s) [305.617882] [013/133] (758s left) gem_exec_fence (submit67) [305.801080] Starting subtest: submit67 [305.805689] Subtest submit67: SKIP (0.000s) [308.005279] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true [308.008655] [014/133] (755s left) kms_big_fb (4-tiled-16bpp-rotate-0) [308.118772] Starting subtest: 4-tiled-16bpp-rotate-0 [309.476040] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.358s) [309.597415] [015/133] (754s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [309.691599] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [309.694901] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [309.796163] [016/133] (754s left) gem_exec_reloc (basic-gtt-wc-noreloc) [309.856038] Subtest basic-gtt-wc-noreloc: SKIP (0.000s) [309.925517] [017/133] (754s left) syncobj_timeline (signal-point-0) [309.991596] Starting subtest: signal-point-0 [309.993623] Subtest signal-point-0: SUCCESS (0.000s) [310.109599] [018/133] (753s left) kms_cursor_legacy (cursor-vs-flip-legacy) [310.225164] Starting subtest: cursor-vs-flip-legacy [339.641514] Subtest cursor-vs-flip-legacy: SUCCESS (29.414s) [340.446518] [019/133] (723s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [340.851703] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [341.652211] [020/133] (722s left) gem_workarounds (basic-read) [341.720993] Starting subtest: basic-read [341.729831] Subtest basic-read: SUCCESS (0.011s) [341.845518] [021/133] (722s left) perf (oa-formats) [341.941214] Starting subtest: oa-formats [341.943658] Starting dynamic subtest: 0-rcs0 [341.956584] Dynamic subtest 0-rcs0: SUCCESS (0.015s) [341.966295] Starting dynamic subtest: 1-vecs0 [341.977413] Dynamic subtest 1-vecs0: SUCCESS (0.021s) [341.979768] Subtest oa-formats: SUCCESS (0.037s) [342.029505] [022/133] (722s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [342.117320] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [342.119711] Starting dynamic subtest: pipe-A [342.182729] Dynamic subtest pipe-A: SUCCESS (0.065s) [342.190882] Starting dynamic subtest: pipe-B [343.297923] Dynamic subtest pipe-B: SUCCESS (1.115s) [343.314027] Starting dynamic subtest: pipe-C [344.414491] Dynamic subtest pipe-C: SUCCESS (1.116s) [344.424037] Starting dynamic subtest: pipe-D [345.541785] Dynamic subtest pipe-D: SUCCESS (1.127s) [345.544050] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.425s) [346.687911] [023/133] (717s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [346.802353] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [353.691768] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.894s) [353.790231] [024/133] (710s left) syncobj_timeline (invalid-transfer-non-existent-point) [353.847126] Starting subtest: invalid-transfer-non-existent-point [353.849493] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [353.930564] [025/133] (710s left) syncobj_wait (wait-for-submit-complex) [353.991084] Starting subtest: wait-for-submit-complex [354.051976] Subtest wait-for-submit-complex: SUCCESS (0.062s) [354.126690] [026/133] (710s left) syncobj_timeline (multi-wait-available-submitted-signaled) [354.182877] Starting subtest: multi-wait-available-submitted-signaled [354.185175] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [354.280138] [027/133] (710s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4) [354.375423] Starting subtest: plane-lut1d-pre-ctm3x4 [354.524827] Starting dynamic subtest: pipe-A-plane-0 [354.845213] Dynamic subtest pipe-A-plane-0: FAIL (0.182s) [354.854375] Starting dynamic subtest: pipe-A-plane-1 [355.063925] Dynamic subtest pipe-A-plane-1: FAIL (0.187s) [355.073763] Starting dynamic subtest: pipe-A-plane-2 [355.282046] Dynamic subtest pipe-A-plane-2: FAIL (0.183s) [356.267874] Starting dynamic subtest: pipe-B-plane-0 [356.737600] Dynamic subtest pipe-B-plane-0: FAIL (0.202s) [356.746825] Starting dynamic subtest: pipe-B-plane-1 [357.063925] Dynamic subtest pipe-B-plane-1: FAIL (0.184s) [357.074097] Starting dynamic subtest: pipe-B-plane-2 [357.369274] Dynamic subtest pipe-B-plane-2: FAIL (0.178s) [358.053374] Starting dynamic subtest: pipe-C-plane-0 [358.532449] Dynamic subtest pipe-C-plane-0: FAIL (0.129s) [358.542496] Starting dynamic subtest: pipe-C-plane-1 [358.948062] Dynamic subtest pipe-C-plane-1: FAIL (0.154s) [358.957968] Starting dynamic subtest: pipe-C-plane-2 [359.320211] Dynamic subtest pipe-C-plane-2: FAIL (0.642s) [360.217751] Starting dynamic subtest: pipe-D-plane-0 [360.830034] Dynamic subtest pipe-D-plane-0: FAIL (0.152s) [360.839600] Starting dynamic subtest: pipe-D-plane-1 [361.298514] Dynamic subtest pipe-D-plane-1: FAIL (0.614s) [361.307781] Starting dynamic subtest: pipe-D-plane-2 [361.743868] Dynamic subtest pipe-D-plane-2: FAIL (0.567s) [361.840531] Subtest plane-lut1d-pre-ctm3x4: FAIL (7.464s) [362.650696] [028/133] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [362.742215] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [367.278231] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.539s) [368.461016] [029/133] (696s left) gem_mmap (big-bo) [368.524153] Subtest big-bo: SKIP (0.000s) [368.584975] [030/133] (695s left) syncobj_eventfd (invalid-bad-pad) [368.636840] Starting subtest: invalid-bad-pad [368.639194] Subtest invalid-bad-pad: SUCCESS (0.000s) [368.741927] [031/133] (695s left) kms_lease (lease-unleased-crtc) [368.832084] Starting subtest: lease-unleased-crtc [368.834651] Starting dynamic subtest: pipe-A-eDP-1 [369.134087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.303s) [369.142463] Starting dynamic subtest: pipe-B-eDP-1 [369.897432] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s) [369.908530] Starting dynamic subtest: pipe-C-eDP-1 [369.911048] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s) [369.918776] Starting dynamic subtest: pipe-D-eDP-1 [369.921056] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s) [369.923288] Subtest lease-unleased-crtc: SUCCESS (1.081s) [370.264105] [032/133] (694s left) i915_pm_rpm (gem-execbuf) [372.090347] Starting subtest: gem-execbuf [372.093260] Starting dynamic subtest: smem0 [373.547699] Dynamic subtest smem0: SUCCESS (1.458s) [373.550094] Subtest gem-execbuf: SUCCESS (1.459s) [373.635488] [033/133] (691s left) kms_cursor_crc (cursor-rapid-movement-max-size) [373.945714] Starting subtest: cursor-rapid-movement-max-size [373.951812] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [374.056969] [034/133] (690s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [374.143288] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [374.145478] Starting dynamic subtest: pipe-A [374.256393] Dynamic subtest pipe-A: SKIP (0.107s) [374.269461] Starting dynamic subtest: pipe-B [375.469408] Dynamic subtest pipe-B: SKIP (1.212s) [375.477436] Starting dynamic subtest: pipe-C [376.697558] Dynamic subtest pipe-C: SUCCESS (1.234s) [376.706615] Starting dynamic subtest: pipe-D [377.919185] Dynamic subtest pipe-D: SUCCESS (1.221s) [377.921589] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.776s) [379.127289] [035/133] (685s left) kms_vrr (max-min) [379.217092] Starting subtest: max-min [379.224133] Subtest max-min: SKIP (0.000s) [379.291567] [036/133] (685s left) gem_userptr_blits (vma-merge) [379.369775] Starting subtest: vma-merge [379.410354] Subtest vma-merge: SUCCESS (0.040s) [379.530907] [037/133] (685s left) syncobj_timeline (host-signal-ordered) [379.586332] Starting subtest: host-signal-ordered [379.588610] Subtest host-signal-ordered: SUCCESS (0.000s) [379.681520] [038/133] (685s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [379.770478] Starting subtest: psr-rgb565-draw-blt [386.777236] Subtest psr-rgb565-draw-blt: SUCCESS (7.011s) [386.922105] [039/133] (678s left) gen9_exec_parse (bb-start-param) [386.990960] Subtest bb-start-param: SKIP (0.000s) [387.059141] [040/133] (677s left) kms_psr (psr2-cursor-mmap-cpu) [387.157764] Starting subtest: psr2-cursor-mmap-cpu [387.160041] Starting dynamic subtest: eDP-1 [388.843975] Dynamic subtest eDP-1: SUCCESS (1.683s) [388.846262] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.685s) [389.730129] [041/133] (675s left) core_setmaster (master-drop-set-user) [389.816317] Starting subtest: master-drop-set-user [389.831455] Subtest master-drop-set-user: SUCCESS (0.015s) [389.873562] [042/133] (675s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [389.971845] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf [389.974174] Starting dynamic subtest: pipe-A-eDP-1 [390.070505] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [390.079182] Starting dynamic subtest: pipe-B-eDP-1 [391.197492] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s) [391.202079] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.227s) [392.478768] [043/133] (672s left) gem_mmap_gtt (basic-copy) [392.536088] Subtest basic-copy: SKIP (0.000s) [392.601497] [044/133] (672s left) kms_vrr (flip-dpms) [392.694895] Starting subtest: flip-dpms [392.701206] Subtest flip-dpms: SKIP (0.000s) [392.764680] [045/133] (672s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [392.887650] Starting subtest: short-busy-flip-before-cursor-toggle [392.893686] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [393.029297] [046/133] (672s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [393.128156] Starting subtest: 2x-wf_vblank-ts-check-interruptible [393.141302] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.012s) [393.247774] [047/133] (672s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping) [393.343070] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping [393.347416] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s) [393.418446] [048/133] (671s left) i915_module_load (reload-no-display) [393.456364] Starting subtest: reload-no-display [399.417460] Subtest reload-no-display: SUCCESS (5.961s) [399.446466] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [399.447292] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [399.450492] [049/133] (665s left) i915_pm_rps (thresholds-park) [401.050268] Starting subtest: thresholds-park [401.055015] Subtest thresholds-park: SKIP (0.002s) [401.097617] [FACT i915_pm_rps (thresholds-park)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [401.099132] [FACT i915_pm_rps (thresholds-park)] new: kernel.kmod_is_loaded.i915: true [401.103405] [050/133] (664s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [401.204169] Starting subtest: flip-primary-invalidate-overlay [412.804611] Subtest flip-primary-invalidate-overlay: SUCCESS (11.602s) [412.945157] [051/133] (652s left) kms_big_fb (4-tiled-8bpp-rotate-270) [413.046511] Starting subtest: 4-tiled-8bpp-rotate-270 [413.069216] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s) [413.199468] [052/133] (652s left) gem_gpgpu_fill (basic) [413.267246] Starting subtest: basic [413.269015] Starting dynamic subtest: smem [413.273564] Dynamic subtest smem: SUCCESS (0.007s) [413.275526] Subtest basic: SUCCESS (0.007s) [413.392100] [053/133] (652s left) kms_sequence (queue-busy) [413.478133] Starting subtest: queue-busy [413.479730] Starting dynamic subtest: pipe-A-eDP-1 [415.419059] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s) [415.427082] Starting dynamic subtest: pipe-B-eDP-1 [418.002444] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.580s) [418.010802] Starting dynamic subtest: pipe-C-eDP-1 [420.614306] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.611s) [420.622670] Starting dynamic subtest: pipe-D-eDP-1 [423.150827] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s) [423.152804] Subtest queue-busy: SUCCESS (9.670s) [423.940156] [054/133] (641s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [424.037691] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [424.041846] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [424.131527] [055/133] (641s left) syncobj_wait (invalid-signal-illegal-handle) [424.182082] Starting subtest: invalid-signal-illegal-handle [424.184459] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [424.282031] [056/133] (641s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [424.386190] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [424.390437] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [424.488872] [057/133] (641s left) gem_mmap_wc (read-write-distinct) [424.559095] Subtest read-write-distinct: SKIP (0.000s) [424.617849] [058/133] (641s left) prime_vgem (shrink) [424.700102] Starting subtest: shrink [424.717966] Subtest shrink: SUCCESS (0.018s) [424.824783] [059/133] (640s left) api_intel_bb (blit-noreloc-keep-cache) [424.885751] Starting subtest: blit-noreloc-keep-cache [424.894771] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s) [425.012062] [060/133] (640s left) vgem_basic (mmap) [425.055496] Starting subtest: mmap [425.064399] Subtest mmap: SUCCESS (0.010s) [425.121897] [061/133] (640s left) perf (invalid-oa-metric-set-id) [425.250192] Starting subtest: invalid-oa-metric-set-id [425.262445] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s) [425.326802] [062/133] (640s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs) [425.419997] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs [425.421850] Starting dynamic subtest: pipe-A-eDP-1 [425.440908] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [425.450078] Starting dynamic subtest: pipe-B-eDP-1 [425.468158] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [425.475628] Starting dynamic subtest: pipe-C-eDP-1 [425.492666] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [425.499381] Starting dynamic subtest: pipe-D-eDP-1 [425.516698] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [425.520141] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.007s) [427.704819] [063/133] (638s left) kms_big_fb (linear-16bpp-rotate-270) [427.806815] Starting subtest: linear-16bpp-rotate-270 [427.825628] Subtest linear-16bpp-rotate-270: SKIP (0.018s) [427.928038] [064/133] (638s left) kms_flip (2x-absolute-wf_vblank) [428.014978] Starting subtest: 2x-absolute-wf_vblank [428.024297] Subtest 2x-absolute-wf_vblank: SKIP (0.011s) [428.139454] [065/133] (637s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [428.249831] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [432.509952] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.264s) [433.725086] [066/133] (632s left) gem_exec_whisper (basic-forked) [433.785900] Starting subtest: basic-forked [441.067895] Subtest basic-forked: SUCCESS (7.280s) [441.249336] [067/133] (624s left) kms_chamelium_audio (dp-audio-edid) [441.646849] Subtest dp-audio-edid: SKIP (0.000s) [442.413837] [068/133] (623s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [442.513018] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [442.515321] Starting dynamic subtest: pipe-A-default-mode [445.276877] Dynamic subtest pipe-A-default-mode: SUCCESS (2.761s) [445.279175] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.763s) [446.117240] [069/133] (620s left) kms_plane_cursor (primary) [446.209867] Starting subtest: primary [446.214494] Starting dynamic subtest: pipe-A-eDP-1-size-64 [448.775986] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.565s) [448.798713] Starting dynamic subtest: pipe-A-eDP-1-size-128 [451.408920] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.616s) [451.432902] Starting dynamic subtest: pipe-A-eDP-1-size-256 [454.044763] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.618s) [454.363193] Starting dynamic subtest: pipe-B-eDP-1-size-64 [457.606980] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.253s) [457.630618] Starting dynamic subtest: pipe-B-eDP-1-size-128 [460.207875] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.582s) [460.232476] Starting dynamic subtest: pipe-B-eDP-1-size-256 [462.797771] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.571s) [463.118847] Starting dynamic subtest: pipe-C-eDP-1-size-64 [466.112091] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.005s) [466.138821] Starting dynamic subtest: pipe-C-eDP-1-size-128 [468.346194] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s) [468.371650] Starting dynamic subtest: pipe-C-eDP-1-size-256 [470.601130] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.236s) [470.920525] Starting dynamic subtest: pipe-D-eDP-1-size-64 [473.824409] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.913s) [473.850935] Starting dynamic subtest: pipe-D-eDP-1-size-128 [476.157303] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.314s) [476.183094] Starting dynamic subtest: pipe-D-eDP-1-size-256 [478.391186] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s) [478.697097] Subtest primary: SUCCESS (32.488s) [479.545409] [070/133] (586s left) gen9_exec_parse (shadow-peek) [479.595323] Subtest shadow-peek: SKIP (0.000s) [479.652961] [071/133] (586s left) gem_mmap_gtt (close-race) [479.719398] Subtest close-race: SKIP (0.000s) [479.778802] [072/133] (586s left) gem_workarounds (reset-fd) [479.845709] Starting subtest: reset-fd [480.040414] Subtest reset-fd: SUCCESS (0.195s) [480.173889] [073/133] (586s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [480.270061] Starting subtest: plane-primary-toggle-with-vblank-wait [480.272305] Starting dynamic subtest: pipe-A-eDP-1 [480.443250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s) [480.751670] Starting dynamic subtest: pipe-B-eDP-1 [481.643477] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.900s) [481.939760] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.671s) [482.809178] [074/133] (583s left) kms_fbcon_fbt (psr) [482.862557] Starting subtest: psr [490.153808] Subtest psr: SUCCESS (7.289s) [490.233212] [075/133] (576s left) kms_psr (fbc-pr-basic) [490.325258] Starting subtest: fbc-pr-basic [490.329092] Subtest fbc-pr-basic: SKIP (0.000s) [490.411205] [076/133] (576s left) kms_psr (pr-primary-blt) [490.505466] Starting subtest: pr-primary-blt [490.510090] Subtest pr-primary-blt: SKIP (0.000s) [490.599959] [077/133] (575s left) gem_exec_balancer (full-pulse) [490.656793] Starting subtest: full-pulse [495.785690] Subtest full-pulse: SUCCESS (5.128s) [496.118311] [078/133] (570s left) gem_exec_schedule (implicit-write-read) [496.190311] Starting subtest: implicit-write-read [496.192606] Starting dynamic subtest: rcs0 [496.375697] Dynamic subtest rcs0: SUCCESS (0.191s) [496.387597] Starting dynamic subtest: vcs0 [496.516437] Dynamic subtest vcs0: SUCCESS (0.140s) [496.528132] Starting dynamic subtest: vcs1 [496.635788] Dynamic subtest vcs1: SUCCESS (0.118s) [496.646403] Starting dynamic subtest: vecs0 [496.741589] Dynamic subtest vecs0: SUCCESS (0.106s) [496.756542] Starting dynamic subtest: ccs0 [496.879088] Dynamic subtest ccs0: SUCCESS (0.136s) [496.881811] Subtest implicit-write-read: SUCCESS (0.696s) [497.968240] [079/133] (568s left) kms_rotation_crc (sprite-rotation-90) [498.060091] Starting subtest: sprite-rotation-90 [498.064655] Subtest sprite-rotation-90: SKIP (0.001s) [498.141562] [080/133] (568s left) kms_feature_discovery (psr2) [498.229895] Starting subtest: psr2 [498.232187] Subtest psr2: SUCCESS (0.000s) [498.303826] [081/133] (568s left) gem_softpin (overlap) [498.369721] Starting subtest: overlap [499.316338] Subtest overlap: SUCCESS (0.946s) [499.442714] [082/133] (567s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [499.548830] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [499.553086] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [499.638545] [083/133] (567s left) perf_pmu (event-wait) [499.678924] Starting subtest: event-wait [499.680844] Starting dynamic subtest: rcs0 [499.685319] Dynamic subtest rcs0: SKIP (0.000s) [499.689687] Subtest event-wait: SKIP (0.001s) [499.787302] [084/133] (567s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [499.884897] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [499.889186] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [499.977019] [085/133] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [500.079598] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [500.083638] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [500.178174] [086/133] (566s left) kms_flip (2x-plain-flip-interruptible) [500.279775] Starting subtest: 2x-plain-flip-interruptible [500.291538] Subtest 2x-plain-flip-interruptible: SKIP (0.012s) [500.368953] [087/133] (566s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [500.463234] Starting subtest: addfb25-yf-tiled-legacy [500.465121] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [500.567911] [088/133] (566s left) api_intel_bb (reset-flags) [500.612755] Starting subtest: reset-flags [500.617023] Subtest reset-flags: SUCCESS (0.007s) [500.744070] [089/133] (566s left) gem_sync (basic-many-each) [500.810208] Starting subtest: basic-many-each [503.103066] Subtest basic-many-each: SUCCESS (2.299s) [503.286806] [090/133] (563s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [503.390320] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [503.394326] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [503.468315] [091/133] (563s left) gem_exec_schedule (preempt-user) [503.533622] Starting subtest: preempt-user [503.535537] Starting dynamic subtest: rcs0 [503.550348] Dynamic subtest rcs0: SUCCESS (0.022s) [503.560617] Starting dynamic subtest: bcs0 [503.569267] Dynamic subtest bcs0: SUCCESS (0.018s) [503.579020] Starting dynamic subtest: vcs0 [503.589356] Dynamic subtest vcs0: SUCCESS (0.019s) [503.601726] Starting dynamic subtest: vcs1 [503.608994] Dynamic subtest vcs1: SUCCESS (0.019s) [503.618540] Starting dynamic subtest: vecs0 [503.630212] Dynamic subtest vecs0: SUCCESS (0.020s) [503.639296] Starting dynamic subtest: ccs0 [503.651947] Dynamic subtest ccs0: SUCCESS (0.021s) [503.654259] Subtest preempt-user: SUCCESS (0.125s) [504.999018] [092/133] (562s left) gem_busy (semaphore) [505.194493] Subtest semaphore: SKIP (0.000s) [505.408329] [093/133] (561s left) kms_pm_rpm (legacy-planes-dpms) [507.030455] Starting subtest: legacy-planes-dpms [507.032989] Starting dynamic subtest: plane-64 [515.421663] Dynamic subtest plane-64: SUCCESS (8.390s) [515.432787] Starting dynamic subtest: plane-94 [524.024601] Dynamic subtest plane-94: SUCCESS (8.600s) [524.036446] Starting dynamic subtest: plane-124 [532.357253] Dynamic subtest plane-124: SUCCESS (8.329s) [532.368920] Starting dynamic subtest: plane-134 [541.020667] Dynamic subtest plane-134: SUCCESS (8.661s) [541.023218] Subtest legacy-planes-dpms: SUCCESS (33.991s) [541.416020] [094/133] (525s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [541.508221] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [541.512289] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s) [541.583371] [095/133] (525s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [541.672804] Starting subtest: primary-x-tiled-reflect-x-0 [548.584584] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.913s) [549.758141] [096/133] (517s left) kms_hdr (bpc-switch-dpms) [549.856853] Starting subtest: bpc-switch-dpms [550.928773] Starting dynamic subtest: pipe-A-eDP-1 [555.463844] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.536s) [555.466299] Subtest bpc-switch-dpms: SUCCESS (5.609s) [555.565843] [097/133] (511s left) gem_mmap_wc (bad-object) [555.626041] Subtest bad-object: SKIP (0.000s) [555.681763] [098/133] (511s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [555.775976] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [555.778269] Starting dynamic subtest: pipe-A-eDP-1 [555.799987] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [555.810026] Starting dynamic subtest: pipe-B-eDP-1 [555.832024] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [555.841060] Starting dynamic subtest: pipe-C-eDP-1 [555.862925] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [555.872656] Starting dynamic subtest: pipe-D-eDP-1 [555.894382] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [555.898419] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s) [558.105506] [099/133] (509s left) prime_mmap (test_forked) [558.166546] Starting subtest: test_forked [558.168865] Starting dynamic subtest: test_forked-smem [558.211063] Dynamic subtest test_forked-smem: SUCCESS (0.045s) [558.213435] Subtest test_forked: SUCCESS (0.046s) [558.316047] [100/133] (509s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [558.441722] Starting subtest: cursorB-vs-flipA-legacy [558.446778] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s) [558.598963] [101/133] (508s left) kms_joiner (basic-big-joiner) [558.703318] Starting subtest: basic-big-joiner [558.707691] Subtest basic-big-joiner: SKIP (0.000s) [558.768291] [102/133] (508s left) syncobj_basic (test-valid-cycle) [558.816087] Starting subtest: test-valid-cycle [558.818074] Subtest test-valid-cycle: SUCCESS (0.000s) [558.914437] [103/133] (508s left) kms_force_connector_basic (force-edid) [558.985190] Starting subtest: force-edid [559.294186] Subtest force-edid: SUCCESS (0.312s) [559.480679] [104/133] (508s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [559.576060] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [559.577898] Starting dynamic subtest: pipe-A-eDP-1 [559.597542] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [559.607706] Starting dynamic subtest: pipe-B-eDP-1 [559.625862] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [559.634443] Starting dynamic subtest: pipe-C-eDP-1 [559.651855] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [559.660118] Starting dynamic subtest: pipe-D-eDP-1 [559.678113] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [559.681444] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s) [561.813535] [105/133] (505s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs) [561.914527] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs [561.916632] Starting dynamic subtest: pipe-A-eDP-1 [561.936524] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [561.946442] Starting dynamic subtest: pipe-B-eDP-1 [561.966887] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [561.975787] Starting dynamic subtest: pipe-C-eDP-1 [561.995726] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [562.004160] Starting dynamic subtest: pipe-D-eDP-1 [562.024247] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [562.026460] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s) [564.112352] [106/133] (503s left) kms_cursor_crc (cursor-offscreen-64x64) [564.283282] Starting subtest: cursor-offscreen-64x64 [564.288338] Starting dynamic subtest: pipe-A-eDP-1 [566.233519] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s) [566.265203] Starting dynamic subtest: pipe-D-eDP-1 [568.881397] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.624s) [568.883735] Subtest cursor-offscreen-64x64: SUCCESS (4.596s) [569.717791] [107/133] (498s left) kms_big_fb (y-tiled-16bpp-rotate-180) [569.827662] Starting subtest: y-tiled-16bpp-rotate-180 [569.832043] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [569.925649] [108/133] (497s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [570.026056] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [570.030476] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [570.128688] [109/133] (497s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [570.222246] Starting subtest: fbc-rgb101010-draw-mmap-cpu [574.745121] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.525s) [575.930316] [110/133] (491s left) perf (short-reads) [576.030494] Starting subtest: short-reads [576.043719] Subtest short-reads: SUCCESS (0.014s) [576.084379] [111/133] (491s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [576.199525] Starting subtest: cursor-tearing-framebuffer-change [576.201466] Starting dynamic subtest: pipe-A-eDP-1 [576.764848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s) [576.773793] Starting dynamic subtest: pipe-D-eDP-1 [578.015555] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.249s) [578.017745] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.818s) [578.811491] [112/133] (489s left) gem_exec_reloc (basic-wc-gtt-active) [578.885183] Subtest basic-wc-gtt-active: SKIP (0.000s) [578.967201] [113/133] (489s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [579.015273] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [579.019744] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [579.200335] [114/133] (488s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [579.307221] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [580.411828] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.104s) [580.547524] [115/133] (487s left) kms_plane_alpha_blend (constant-alpha-max) [580.650070] Starting subtest: constant-alpha-max [580.933347] Starting dynamic subtest: pipe-A-eDP-1 [581.953070] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.019s) [581.962783] Starting dynamic subtest: pipe-D-eDP-1 [583.610252] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.655s) [583.612614] Subtest constant-alpha-max: SUCCESS (2.960s) [584.410298] [116/133] (483s left) kms_psr (fbc-psr2-cursor-render) [584.502441] Starting subtest: fbc-psr2-cursor-render [584.504818] Starting dynamic subtest: eDP-1 [584.509219] Dynamic subtest eDP-1: SKIP (0.000s) [584.513542] Subtest fbc-psr2-cursor-render: SKIP (0.001s) [584.574868] [117/133] (483s left) kms_chamelium_edid (dp-edid-resolution-list) [584.976997] Subtest dp-edid-resolution-list: SKIP (0.000s) [585.791187] [118/133] (482s left) gem_eio (wait-wedge-1us) [586.035118] Starting subtest: wait-wedge-1us [588.012230] Subtest wait-wedge-1us: SUCCESS (1.975s) [588.128343] [119/133] (480s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [588.249527] Starting subtest: flip-vs-cursor-busy-crc-atomic [589.064785] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.813s) [589.903830] [120/133] (478s left) gem_ctx_shared (q-promotion) [589.966055] Starting subtest: Q-promotion [589.968298] Starting dynamic subtest: rcs0 [590.084790] Dynamic subtest rcs0: SUCCESS (0.116s) [590.096037] Starting dynamic subtest: vcs0 [590.178404] Dynamic subtest vcs0: SUCCESS (0.094s) [590.194545] Starting dynamic subtest: vcs1 [590.269550] Dynamic subtest vcs1: SUCCESS (0.090s) [590.285541] Starting dynamic subtest: vecs0 [590.355233] Dynamic subtest vecs0: SUCCESS (0.084s) [590.369659] Starting dynamic subtest: ccs0 [590.451851] Dynamic subtest ccs0: SUCCESS (0.095s) [590.454192] Subtest Q-promotion: SUCCESS (0.486s) [591.986378] [121/133] (476s left) kms_pm_lpsp (kms-lpsp) [593.088638] Starting subtest: kms-lpsp [593.090860] Starting dynamic subtest: pipe-A-eDP-1 [593.234054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s) [593.530828] Subtest kms-lpsp: SUCCESS (0.446s) [594.412961] [122/133] (473s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [594.526266] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [601.156456] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.633s) [601.304607] [123/133] (467s left) gem_exec_fence (basic-wait) [601.481811] Starting subtest: basic-wait [601.484331] Starting dynamic subtest: rcs0 [601.563813] Dynamic subtest rcs0: SUCCESS (0.081s) [601.575077] Starting dynamic subtest: bcs0 [601.629937] Dynamic subtest bcs0: SUCCESS (0.064s) [601.641312] Starting dynamic subtest: vcs0 [601.686913] Dynamic subtest vcs0: SUCCESS (0.055s) [601.700522] Starting dynamic subtest: vcs1 [601.742104] Dynamic subtest vcs1: SUCCESS (0.052s) [601.755099] Starting dynamic subtest: vecs0 [601.802992] Dynamic subtest vecs0: SUCCESS (0.058s) [601.812073] Starting dynamic subtest: ccs0 [601.862345] Dynamic subtest ccs0: SUCCESS (0.057s) [601.864754] Subtest basic-wait: SUCCESS (0.382s) [604.025707] [124/133] (464s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [604.131066] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [604.135258] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [604.236710] [125/133] (464s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [604.328404] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [604.332399] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [604.430244] [126/133] (464s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [604.541796] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [604.545918] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [604.640395] [127/133] (463s left) gem_workarounds (suspend-resume) [604.709048] Starting subtest: suspend-resume [621.024155] Subtest suspend-resume: SUCCESS (2.015s) [621.174525] [128/133] (447s left) gem_ctx_isolation (preservation-s3) [621.253951] Starting subtest: preservation-S3 [621.256282] Starting dynamic subtest: rcs0 [637.069100] Dynamic subtest rcs0: SUCCESS (1.312s) [637.079540] Starting dynamic subtest: bcs0 [655.371672] Dynamic subtest bcs0: SUCCESS (3.668s) [655.383437] Starting dynamic subtest: vcs0 [672.091330] Dynamic subtest vcs0: SUCCESS (3.060s) [672.102499] Starting dynamic subtest: vcs1 [690.081604] Dynamic subtest vcs1: SUCCESS (4.970s) [690.094900] Starting dynamic subtest: vecs0 [708.074584] Dynamic subtest vecs0: SUCCESS (4.985s) [708.085595] Starting dynamic subtest: ccs0 [728.355082] Dynamic subtest ccs0: SUCCESS (5.468s) [728.357553] Subtest preservation-S3: SUCCESS (23.468s) [736.620709] [129/133] (340s left) kms_flip (nonexisting-fb-interruptible) [736.736367] Starting subtest: nonexisting-fb-interruptible [736.738720] Starting dynamic subtest: A-eDP1 [737.856179] Dynamic subtest A-eDP1: SUCCESS (1.117s) [737.867007] Starting dynamic subtest: B-eDP1 [738.944371] Dynamic subtest B-eDP1: SUCCESS (1.085s) [738.955352] Starting dynamic subtest: C-eDP1 [740.054100] Dynamic subtest C-eDP1: SUCCESS (1.107s) [740.067283] Starting dynamic subtest: D-eDP1 [741.169988] Dynamic subtest D-eDP1: SUCCESS (1.111s) [741.175178] Subtest nonexisting-fb-interruptible: SUCCESS (4.431s) [742.398167] [130/133] (334s left) gem_mmap_offset (close-race) [742.458487] Starting subtest: close-race [762.567768] Subtest close-race: SUCCESS (20.096s) [762.689297] [131/133] (314s left) gem_exec_fence (syncobj-timeline-wait) [763.278840] Starting subtest: syncobj-timeline-wait [764.832952] Subtest syncobj-timeline-wait: SUCCESS (1.553s) [766.872678] [132/133] (309s left) kms_big_fb (x-tiled-addfb) [766.988235] Starting subtest: x-tiled-addfb [766.990330] Subtest x-tiled-addfb: SUCCESS (0.000s) [767.098834] [133/133] (309s left) kms_addfb_basic (unused-offsets) [767.170126] Starting subtest: unused-offsets [767.172494] Subtest unused-offsets: SUCCESS (0.000s) [767.299302] Closing watchdogs results: parsing output: 0/ for test: kms_feature_discovery results: parsing output: 1/ for test: perf results: parsing output: 2/ for test: kms_content_protection results: parsing output: 3/ for test: kms_flip results: parsing output: 4/ for test: gem_ctx_persistence results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_pxp results: parsing output: 7/ for test: gem_softpin results: parsing output: 8/ for test: gem_ccs results: parsing output: 9/ for test: sysfs_timeslice_duration results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: kms_busy results: parsing output: 12/ for test: gem_exec_fence results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_exec_reloc results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: kms_cursor_legacy results: parsing output: 18/ for test: kms_chamelium_hpd results: parsing output: 19/ for test: gem_workarounds results: parsing output: 20/ for test: perf results: parsing output: 21/ for test: kms_plane_scaling results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: syncobj_wait results: parsing output: 25/ for test: syncobj_timeline results: parsing output: 26/ for test: kms_color_pipeline results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: gem_mmap results: parsing output: 29/ for test: syncobj_eventfd results: parsing output: 30/ for test: kms_lease results: parsing output: 31/ for test: i915_pm_rpm results: parsing output: 32/ for test: kms_cursor_crc results: parsing output: 33/ for test: kms_plane_scaling results: parsing output: 34/ for test: kms_vrr results: parsing output: 35/ for test: gem_userptr_blits results: parsing output: 36/ for test: syncobj_timeline results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gen9_exec_parse results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: core_setmaster results: parsing output: 41/ for test: kms_psr2_sf results: parsing output: 42/ for test: gem_mmap_gtt results: parsing output: 43/ for test: kms_vrr results: parsing output: 44/ for test: kms_cursor_legacy results: parsing output: 45/ for test: kms_flip results: parsing output: 46/ for test: kms_plane results: parsing output: 47/ for test: i915_module_load results: parsing output: 48/ for test: i915_pm_rps results: parsing output: 49/ for test: kms_psr_stress_test results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: gem_gpgpu_fill results: parsing output: 52/ for test: kms_sequence results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: syncobj_wait results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_mmap_wc results: parsing output: 57/ for test: prime_vgem results: parsing output: 58/ for test: api_intel_bb results: parsing output: 59/ for test: vgem_basic results: parsing output: 60/ for test: perf results: parsing output: 61/ for test: kms_ccs results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: kms_flip results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_exec_whisper results: parsing output: 66/ for test: kms_chamelium_audio results: parsing output: 67/ for test: kms_flip_scaled_crc results: parsing output: 68/ for test: kms_plane_cursor results: parsing output: 69/ for test: gen9_exec_parse results: parsing output: 70/ for test: gem_mmap_gtt results: parsing output: 71/ for test: gem_workarounds results: parsing output: 72/ for test: kms_atomic_transition results: parsing output: 73/ for test: kms_fbcon_fbt results: parsing output: 74/ for test: kms_psr results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: gem_exec_balancer results: parsing output: 77/ for test: gem_exec_schedule results: parsing output: 78/ for test: kms_rotation_crc results: parsing output: 79/ for test: kms_feature_discovery results: parsing output: 80/ for test: gem_softpin results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: perf_pmu results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_flip results: parsing output: 86/ for test: kms_addfb_basic results: parsing output: 87/ for test: api_intel_bb results: parsing output: 88/ for test: gem_sync results: parsing output: 89/ for test: kms_psr2_sf results: parsing output: 90/ for test: gem_exec_schedule results: parsing output: 91/ for test: gem_busy results: parsing output: 92/ for test: kms_pm_rpm results: parsing output: 93/ for test: kms_flip_scaled_crc results: parsing output: 94/ for test: kms_rotation_crc results: parsing output: 95/ for test: kms_hdr results: parsing output: 96/ for test: gem_mmap_wc results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: prime_mmap results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_joiner results: parsing output: 101/ for test: syncobj_basic results: parsing output: 102/ for test: kms_force_connector_basic results: parsing output: 103/ for test: kms_ccs results: parsing output: 104/ for test: kms_ccs results: parsing output: 105/ for test: kms_cursor_crc results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: perf results: parsing output: 110/ for test: kms_cursor_crc results: parsing output: 111/ for test: gem_exec_reloc results: parsing output: 112/ for test: gem_render_copy results: parsing output: 113/ for test: kms_big_fb results: parsing output: 114/ for test: kms_plane_alpha_blend results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_chamelium_edid results: parsing output: 117/ for test: gem_eio results: parsing output: 118/ for test: kms_cursor_legacy results: parsing output: 119/ for test: gem_ctx_shared results: parsing output: 120/ for test: kms_pm_lpsp results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gem_exec_fence results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_workarounds results: parsing output: 127/ for test: gem_ctx_isolation results: parsing output: 128/ for test: kms_flip results: parsing output: 129/ for test: gem_mmap_offset results: parsing output: 130/ for test: gem_exec_fence results: parsing output: 131/ for test: kms_big_fb results: parsing output: 132/ for test: kms_addfb_basic Done.