[71.759767] Initializing watchdogs [71.759835] /dev/watchdog0 [71.780239] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [71.792206] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [71.795925] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [71.798727] [001/131] (960s left) kms_psr (pr-dpms) [73.344293] Subtest pr-dpms: SKIP (0.000s) [73.400650] [002/131] (958s left) kms_psr (psr-sprite-mmap-gtt) [74.922220] Subtest psr-sprite-mmap-gtt: SKIP (0.000s) [75.061157] [003/131] (957s left) gem_exec_fence (submit-chain) [75.293615] Starting subtest: submit-chain [75.365631] Subtest submit-chain: SUCCESS (0.073s) [76.104788] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true [76.106864] [004/131] (956s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [77.625558] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [77.626461] Starting dynamic subtest: pipe-A-HDMI-A-1 [77.635624] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [77.643247] Starting dynamic subtest: pipe-B-HDMI-A-1 [77.652082] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [77.659400] Starting dynamic subtest: pipe-C-HDMI-A-1 [77.668143] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [77.675722] Starting dynamic subtest: pipe-D-HDMI-A-1 [77.686152] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [77.688348] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.004s) [77.953490] [005/131] (954s left) gem_userptr_blits (nohangcheck) [78.063153] Starting subtest: nohangcheck [78.372008] Subtest nohangcheck: SUCCESS (0.310s) [78.527913] [006/131] (954s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [78.616932] Starting subtest: invalid-multi-wait-unsubmitted-submitted [78.617880] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [78.763396] [007/131] (953s left) gem_mmap_offset (oob-read) [78.849060] Starting subtest: oob-read [78.849988] Subtest oob-read: SUCCESS (0.000s) [78.977360] [008/131] (953s left) gem_exec_params (larger-than-life-batch) [79.064855] Starting subtest: larger-than-life-batch [89.002512] Subtest larger-than-life-batch: SUCCESS (9.942s) [89.489071] [009/131] (943s left) gem_ctx_persistence (engines-persistence) [89.657972] Starting subtest: engines-persistence [89.658954] Starting dynamic subtest: rcs0 [90.559185] Dynamic subtest rcs0: SUCCESS (0.902s) [90.567519] Starting dynamic subtest: bcs0 [91.320198] Dynamic subtest bcs0: SUCCESS (0.760s) [91.330764] Starting dynamic subtest: vcs0 [92.092169] Dynamic subtest vcs0: SUCCESS (0.771s) [92.103505] Starting dynamic subtest: vcs1 [92.869336] Dynamic subtest vcs1: SUCCESS (0.776s) [92.880470] Starting dynamic subtest: vecs0 [93.632288] Dynamic subtest vecs0: SUCCESS (0.762s) [93.643441] Starting dynamic subtest: vecs1 [94.398323] Dynamic subtest vecs1: SUCCESS (0.765s) [94.409012] Starting dynamic subtest: ccs0 [95.168581] Dynamic subtest ccs0: SUCCESS (0.769s) [95.170595] Subtest engines-persistence: SUCCESS (5.512s) [95.386829] [010/131] (937s left) prime_busy (before-wait) [95.474472] Starting subtest: before-wait [95.479245] Starting dynamic subtest: rcs0 [95.542268] Dynamic subtest rcs0: SUCCESS (0.063s) [95.551273] Starting dynamic subtest: bcs0 [95.604879] Dynamic subtest bcs0: SUCCESS (0.063s) [95.615642] Starting dynamic subtest: vcs0 [95.645528] Dynamic subtest vcs0: SUCCESS (0.040s) [95.660946] Starting dynamic subtest: vcs1 [95.694037] Dynamic subtest vcs1: SUCCESS (0.048s) [95.723625] Starting dynamic subtest: vecs0 [95.736310] Dynamic subtest vecs0: SUCCESS (0.042s) [95.755330] Starting dynamic subtest: vecs1 [95.777044] Dynamic subtest vecs1: SUCCESS (0.040s) [95.789418] Starting dynamic subtest: ccs0 [95.818654] Dynamic subtest ccs0: SUCCESS (0.041s) [95.934744] Subtest before-wait: SUCCESS (0.458s) [96.152129] [011/131] (936s left) kms_psr (fbc-pr-primary-page-flip) [97.681196] Subtest fbc-pr-primary-page-flip: SKIP (0.000s) [97.824981] [012/131] (935s left) kms_setmode (basic-clone-single-crtc) [97.918465] Starting subtest: basic-clone-single-crtc [97.921355] Subtest basic-clone-single-crtc: SKIP (0.000s) [98.106068] [013/131] (935s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [99.630674] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s) [99.698257] [014/131] (933s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [99.794892] Starting subtest: multi-wait-available-unsubmitted-signaled [99.795815] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [99.995919] [015/131] (933s left) gem_fenced_exec_thrash (no-spare-fences-busy) [100.081103] Subtest no-spare-fences-busy: SKIP (0.000s) [100.145189] [016/131] (933s left) gem_lmem_evict (dontneed-evict-race) [104.888064] Starting subtest: dontneed-evict-race [106.969775] Subtest dontneed-evict-race: SUCCESS (2.083s) [108.852223] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [108.853234] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true [108.854931] [017/131] (924s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [113.871572] Starting subtest: 2x-cursor-vs-flip-atomic [113.874424] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s) [114.121153] [FACT kms_cursor_legacy (2x-cursor-vs-flip-atomic)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [114.123891] [FACT kms_cursor_legacy (2x-cursor-vs-flip-atomic)] new: kernel.kmod_is_loaded.i915: true [114.136189] [018/131] (919s left) kms_chamelium_edid (dp-edid-read) [115.702334] Subtest dp-edid-read: SKIP (0.000s) [115.802705] [019/131] (917s left) gem_ccs (block-multicopy-compressed) [115.901080] Starting subtest: block-multicopy-compressed [115.901992] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy [115.955409] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.055s) [115.964516] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy [116.056728] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.101s) [116.065040] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy [116.072938] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s) [116.081286] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy [116.171640] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.098s) [116.179938] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy [116.188122] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s) [116.196407] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy [116.294113] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.106s) [116.302367] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy [116.310847] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.016s) [116.319197] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy [116.410394] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.099s) [116.411369] Subtest block-multicopy-compressed: SUCCESS (0.511s) [116.587214] [020/131] (917s left) i915_pm_rpm (system-suspend-execbuf) [121.072871] Starting subtest: system-suspend-execbuf [181.729362] Subtest system-suspend-execbuf: SUCCESS (44.795s) [182.732813] [021/131] (851s left) kms_vblank (query-forked) [184.251760] Starting subtest: query-forked [184.253634] Starting dynamic subtest: pipe-A-HDMI-A-1 [186.616426] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.363s) [186.629949] Starting dynamic subtest: pipe-D-HDMI-A-1 [188.892435] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.274s) [188.893363] Subtest query-forked: SUCCESS (4.641s) [189.135803] [022/131] (844s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [190.659110] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [190.802590] [023/131] (843s left) kms_psr (fbc-psr-suspend) [192.325382] Subtest fbc-psr-suspend: SKIP (0.000s) [192.396695] [024/131] (841s left) gen9_exec_parse (bb-chained) [192.493408] Subtest bb-chained: SKIP (0.000s) [192.583161] [025/131] (841s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [194.106935] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [194.108729] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [194.332121] [026/131] (839s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [195.857793] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [195.859679] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [196.085889] [027/131] (838s left) gem_mmap_wc (bad-size) [196.168254] Subtest bad-size: SKIP (0.000s) [196.247835] [028/131] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [197.769749] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [197.771431] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [198.004610] [029/131] (836s left) api_intel_allocator (execbuf-with-allocator) [198.102166] Starting subtest: execbuf-with-allocator [198.133402] Subtest execbuf-with-allocator: SUCCESS (0.032s) [198.329902] [030/131] (836s left) gem_exec_schedule (pi-common) [198.552701] Starting subtest: pi-common [198.554098] Starting dynamic subtest: rcs0 [198.594787] Dynamic subtest rcs0: SUCCESS (0.045s) [198.605952] Starting dynamic subtest: bcs0 [198.624299] Dynamic subtest bcs0: SUCCESS (0.029s) [198.635358] Starting dynamic subtest: vcs0 [198.654134] Dynamic subtest vcs0: SUCCESS (0.029s) [198.664821] Starting dynamic subtest: vcs1 [198.684735] Dynamic subtest vcs1: SUCCESS (0.030s) [198.695585] Starting dynamic subtest: vecs0 [198.715317] Dynamic subtest vecs0: SUCCESS (0.030s) [198.726703] Starting dynamic subtest: vecs1 [198.744457] Dynamic subtest vecs1: SUCCESS (0.029s) [198.755352] Starting dynamic subtest: ccs0 [198.772830] Dynamic subtest ccs0: SUCCESS (0.028s) [198.773872] Subtest pi-common: SUCCESS (0.224s) [199.088568] [031/131] (835s left) gem_caching (reads) [199.176580] Starting subtest: reads [202.348575] Subtest reads: SUCCESS (3.171s) [202.554730] [032/131] (832s left) perf_pmu (init-wait) [202.627979] Starting subtest: init-wait [202.628899] Starting dynamic subtest: rcs0 [202.630835] Dynamic subtest rcs0: SUCCESS (0.003s) [202.641785] Starting dynamic subtest: bcs0 [202.642691] Dynamic subtest bcs0: SUCCESS (0.001s) [202.653379] Starting dynamic subtest: vcs0 [202.654301] Dynamic subtest vcs0: SUCCESS (0.001s) [202.665002] Starting dynamic subtest: vcs1 [202.666178] Dynamic subtest vcs1: SUCCESS (0.001s) [202.676777] Starting dynamic subtest: vecs0 [202.677722] Dynamic subtest vecs0: SUCCESS (0.000s) [202.688791] Starting dynamic subtest: vecs1 [202.689996] Dynamic subtest vecs1: SUCCESS (0.000s) [202.700419] Starting dynamic subtest: ccs0 [202.701564] Dynamic subtest ccs0: SUCCESS (0.000s) [202.702618] Subtest init-wait: SUCCESS (0.008s) [202.793128] [033/131] (832s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [204.318250] Starting subtest: cursorA-vs-flipB-varying-size [204.320098] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [204.534369] [034/131] (830s left) perf (mi-rpc) [204.997422] Starting subtest: mi-rpc [204.999180] Subtest mi-rpc: SKIP (0.000s) [205.051439] [035/131] (830s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render) [206.579148] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render [206.581088] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [206.808452] [036/131] (828s left) kms_addfb_basic (invalid-set-prop) [206.890318] Starting subtest: invalid-set-prop [206.891183] Subtest invalid-set-prop: SUCCESS (0.000s) [208.577671] [037/131] (826s left) kms_chamelium_hpd (dp-hpd-fast) [210.146528] Subtest dp-hpd-fast: SKIP (0.000s) [210.250290] [038/131] (825s left) kms_color (ctm-red-to-blue) [211.772583] Starting subtest: ctm-red-to-blue [211.773541] Starting dynamic subtest: pipe-A-HDMI-A-1 [212.472843] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.699s) [212.485331] Starting dynamic subtest: pipe-B-HDMI-A-1 [212.969653] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.496s) [212.980820] Starting dynamic subtest: pipe-C-HDMI-A-1 [213.470669] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.500s) [213.481712] Starting dynamic subtest: pipe-D-HDMI-A-1 [213.992509] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.521s) [213.993405] Subtest ctm-red-to-blue: SUCCESS (2.219s) [214.245619] [039/131] (821s left) gem_tiled_partial_pwrite_pread (writes) [214.331447] Subtest writes: SKIP (0.000s) [214.396832] [040/131] (821s left) gem_exec_schedule (wide) [214.618632] Starting subtest: wide [214.625508] Starting dynamic subtest: rcs0 [227.288128] Dynamic subtest rcs0: SUCCESS (12.673s) [227.315183] Starting dynamic subtest: bcs0 [240.807247] Dynamic subtest bcs0: SUCCESS (13.478s) [240.823736] Starting dynamic subtest: vcs0 [254.330394] Dynamic subtest vcs0: SUCCESS (13.561s) [254.342419] Starting dynamic subtest: vcs1 [268.231923] Dynamic subtest vcs1: SUCCESS (13.904s) [268.243569] Starting dynamic subtest: vecs0 [281.848215] Dynamic subtest vecs0: SUCCESS (13.616s) [281.860154] Starting dynamic subtest: vecs1 [295.902551] Dynamic subtest vecs1: SUCCESS (14.051s) [295.914332] Starting dynamic subtest: ccs0 [309.936679] Dynamic subtest ccs0: SUCCESS (14.032s) [309.937602] Subtest wide: SUCCESS (95.320s) [311.888852] [041/131] (723s left) gem_pxp (hw-rejects-pxp-context) [314.496444] Starting subtest: hw-rejects-pxp-context [314.499591] Subtest hw-rejects-pxp-context: SUCCESS (0.004s) [314.651130] [042/131] (721s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [316.178357] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [316.248805] [043/131] (719s left) gem_mmap_gtt (coherency) [316.346181] Subtest coherency: SKIP (0.000s) [316.446869] [044/131] (719s left) gem_softpin (softpin) [316.539454] Starting subtest: softpin [348.807117] Subtest softpin: SUCCESS (32.258s) [348.983311] [045/131] (686s left) api_intel_bb (object-reloc-purge-cache) [349.063241] Starting subtest: object-reloc-purge-cache [349.065108] Subtest object-reloc-purge-cache: SKIP (0.002s) [349.215248] [046/131] (686s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [350.738242] Starting subtest: psr-indfb-scaledprimary [350.740144] Subtest psr-indfb-scaledprimary: SKIP (0.000s) [350.982620] [047/131] (685s left) gem_spin_batch (resubmit-new) [351.079321] Starting subtest: resubmit-new [351.080263] Starting dynamic subtest: rcs0 [351.116157] Dynamic subtest rcs0: SUCCESS (0.037s) [351.128195] Starting dynamic subtest: bcs0 [351.129214] Dynamic subtest bcs0: SUCCESS (0.005s) [351.140974] Starting dynamic subtest: vcs0 [351.141860] Dynamic subtest vcs0: SUCCESS (0.006s) [351.153852] Starting dynamic subtest: vcs1 [351.154900] Dynamic subtest vcs1: SUCCESS (0.007s) [351.166671] Starting dynamic subtest: vecs0 [351.167716] Dynamic subtest vecs0: SUCCESS (0.005s) [351.178942] Starting dynamic subtest: vecs1 [351.179955] Dynamic subtest vecs1: SUCCESS (0.005s) [351.191304] Starting dynamic subtest: ccs0 [351.192364] Dynamic subtest ccs0: SUCCESS (0.005s) [351.193643] Subtest resubmit-new: SUCCESS (0.071s) [351.488536] [048/131] (684s left) i915_drm_fdinfo (idle) [351.561187] Starting subtest: idle [351.562192] Starting dynamic subtest: rcs0 [352.150836] Dynamic subtest rcs0: SUCCESS (0.589s) [352.179355] Starting dynamic subtest: bcs0 [352.656876] Dynamic subtest bcs0: SUCCESS (0.504s) [352.669833] Starting dynamic subtest: vcs0 [353.163525] Dynamic subtest vcs0: SUCCESS (0.504s) [353.175716] Starting dynamic subtest: vcs1 [353.670121] Dynamic subtest vcs1: SUCCESS (0.504s) [353.682444] Starting dynamic subtest: vecs0 [354.176502] Dynamic subtest vecs0: SUCCESS (0.504s) [354.188843] Starting dynamic subtest: vecs1 [354.682369] Dynamic subtest vecs1: SUCCESS (0.504s) [354.694272] Starting dynamic subtest: ccs0 [355.188251] Dynamic subtest ccs0: SUCCESS (0.503s) [355.189557] Subtest idle: SUCCESS (3.626s) [355.314241] [049/131] (680s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [356.832375] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [356.834302] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [357.108869] [050/131] (679s left) prime_vgem (basic-gtt) [357.208492] Starting subtest: basic-gtt [357.210418] Subtest basic-gtt: SKIP (0.000s) [357.402807] [051/131] (678s left) kms_pm_rpm (dpms-mode-unset-lpsp) [361.653846] Starting subtest: dpms-mode-unset-lpsp [364.661262] Subtest dpms-mode-unset-lpsp: SUCCESS (3.010s) [365.730563] [052/131] (670s left) syncobj_timeline (invalid-query-bad-pad) [365.810491] Starting subtest: invalid-query-bad-pad [365.811514] Subtest invalid-query-bad-pad: SUCCESS (0.000s) [366.000211] [053/131] (670s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [367.528177] Starting subtest: basic-flip-after-cursor-legacy [368.523221] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.994s) [368.776380] [054/131] (667s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [370.309230] Starting subtest: yf-tiled-32bpp-rotate-180 [370.311146] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [370.541323] [055/131] (666s left) gem_exec_balancer (full-pulse) [370.639368] Starting subtest: full-pulse [372.826412] Subtest full-pulse: SUCCESS (2.187s) [373.271041] [056/131] (663s left) dumb_buffer (create-valid-dumb) [373.352257] Starting subtest: create-valid-dumb [373.353229] Subtest create-valid-dumb: SUCCESS (0.000s) [373.526104] [057/131] (663s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [375.055185] Starting subtest: fbc-modesetfrombusy [376.356477] Subtest fbc-modesetfrombusy: SUCCESS (1.303s) [376.559125] [058/131] (660s left) gem_ctx_sseu (invalid-args) [376.652477] Subtest invalid-args: SKIP (0.000s) [376.720521] [059/131] (660s left) kms_big_fb (x-tiled-16bpp-rotate-270) [378.261631] Starting subtest: x-tiled-16bpp-rotate-270 [378.323703] Subtest x-tiled-16bpp-rotate-270: SKIP (0.062s) [378.549406] [060/131] (658s left) gem_exec_flush (basic-uc-ro-default) [378.633620] Subtest basic-uc-ro-default: SKIP (0.000s) [378.725596] [061/131] (658s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [380.250840] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [380.252471] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [380.491221] [062/131] (656s left) kms_async_flips (test-cursor) [382.009932] Starting subtest: test-cursor [382.260646] Starting dynamic subtest: pipe-A-HDMI-A-1 [382.521387] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.261s) [382.724334] Starting dynamic subtest: pipe-B-HDMI-A-1 [382.785993] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.074s) [382.970798] Starting dynamic subtest: pipe-C-HDMI-A-1 [383.059007] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.100s) [383.240096] Starting dynamic subtest: pipe-D-HDMI-A-1 [383.318411] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.091s) [383.319346] Subtest test-cursor: SUCCESS (1.309s) [383.749770] [063/131] (653s left) syncobj_timeline (device-signal-unordered) [383.830387] Starting subtest: device-signal-unordered [383.831329] Subtest device-signal-unordered: SUCCESS (0.001s) [384.019165] [064/131] (653s left) gem_ctx_persistence (legacy-engines-mixed-process) [384.104608] Starting subtest: legacy-engines-mixed-process [384.105576] Starting dynamic subtest: render [385.596992] Dynamic subtest render: SUCCESS (1.492s) [385.611391] Starting dynamic subtest: bsd1 [387.597533] Dynamic subtest bsd1: SUCCESS (1.999s) [387.612800] Starting dynamic subtest: bsd2 [389.567186] Dynamic subtest bsd2: SUCCESS (1.968s) [389.582404] Starting dynamic subtest: blt [391.558233] Dynamic subtest blt: SUCCESS (1.990s) [391.573377] Starting dynamic subtest: vebox [393.539911] Dynamic subtest vebox: SUCCESS (1.981s) [393.541171] Subtest legacy-engines-mixed-process: SUCCESS (9.438s) [393.681948] [065/131] (643s left) prime_mmap (test_refcounting) [393.759910] Starting subtest: test_refcounting [393.760808] Starting dynamic subtest: test_refcounting-smem [393.808566] Dynamic subtest test_refcounting-smem: SUCCESS (0.048s) [393.821478] Starting dynamic subtest: test_refcounting-lmem0 [394.014099] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.205s) [394.015182] Subtest test_refcounting: SUCCESS (0.254s) [394.215457] [066/131] (643s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [394.296378] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [394.376668] [067/131] (643s left) syncobj_wait (wait-for-submit-delayed-submit) [394.457677] Starting subtest: wait-for-submit-delayed-submit [394.558956] Subtest wait-for-submit-delayed-submit: SUCCESS (0.101s) [394.681470] [068/131] (643s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [396.203097] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [398.744546] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.543s) [399.013751] [069/131] (638s left) perf (invalid-open-flags) [399.270791] Starting subtest: invalid-open-flags [399.271702] Subtest invalid-open-flags: SUCCESS (0.000s) [399.328444] [070/131] (638s left) i915_fb_tiling (basic-x-tiling) [399.410261] Subtest basic-x-tiling: SKIP (0.000s) [399.474895] [071/131] (638s left) kms_lease (lease-unleased-connector) [400.989782] Starting subtest: lease-unleased-connector [400.991868] Starting dynamic subtest: pipe-A-HDMI-A-1 [401.048915] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.057s) [401.062404] Starting dynamic subtest: pipe-B-HDMI-A-1 [401.106546] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.057s) [401.121544] Starting dynamic subtest: pipe-C-HDMI-A-1 [401.164586] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.056s) [401.179508] Starting dynamic subtest: pipe-D-HDMI-A-1 [401.222428] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.057s) [401.223655] Subtest lease-unleased-connector: SUCCESS (0.233s) [401.374461] [072/131] (636s left) kms_plane_lowres (tiling-yf) [402.900692] Starting subtest: tiling-yf [402.902496] Subtest tiling-yf: SKIP (0.000s) [403.118573] [073/131] (635s left) kms_flip (flip-vs-panning) [404.637870] Starting subtest: flip-vs-panning [404.642189] Starting dynamic subtest: A-HDMI-A1 [412.412881] Dynamic subtest A-HDMI-A1: SUCCESS (7.771s) [412.432228] Starting dynamic subtest: B-HDMI-A1 [420.116537] Dynamic subtest B-HDMI-A1: SUCCESS (7.702s) [420.158528] Starting dynamic subtest: C-HDMI-A1 [427.853389] Dynamic subtest C-HDMI-A1: SUCCESS (7.733s) [427.870893] Starting dynamic subtest: D-HDMI-A1 [435.556222] Dynamic subtest D-HDMI-A1: SUCCESS (7.699s) [435.558473] Subtest flip-vs-panning: SUCCESS (30.922s) [435.843068] [074/131] (602s left) kms_flip (dpms-off-confusion-interruptible) [437.369776] Starting subtest: dpms-off-confusion-interruptible [437.374416] Starting dynamic subtest: A-HDMI-A1 [445.118794] Dynamic subtest A-HDMI-A1: SUCCESS (7.744s) [445.139582] Starting dynamic subtest: B-HDMI-A1 [452.792169] Dynamic subtest B-HDMI-A1: SUCCESS (7.671s) [452.828556] Starting dynamic subtest: C-HDMI-A1 [460.479466] Dynamic subtest C-HDMI-A1: SUCCESS (7.683s) [460.495610] Starting dynamic subtest: D-HDMI-A1 [468.150855] Dynamic subtest D-HDMI-A1: SUCCESS (7.670s) [468.153177] Subtest dpms-off-confusion-interruptible: SUCCESS (30.781s) [468.425065] [075/131] (569s left) kms_flip (basic-flip-vs-wf_vblank) [469.948517] Starting subtest: basic-flip-vs-wf_vblank [469.953008] Starting dynamic subtest: A-HDMI-A1 [470.998000] Dynamic subtest A-HDMI-A1: SUCCESS (1.045s) [471.016069] Starting dynamic subtest: B-HDMI-A1 [471.968935] Dynamic subtest B-HDMI-A1: SUCCESS (0.969s) [471.984648] Starting dynamic subtest: C-HDMI-A1 [472.940890] Dynamic subtest C-HDMI-A1: SUCCESS (0.971s) [472.956363] Starting dynamic subtest: D-HDMI-A1 [473.911580] Dynamic subtest D-HDMI-A1: SUCCESS (0.969s) [473.913924] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.965s) [474.209005] [076/131] (564s left) kms_big_fb (y-tiled-16bpp-rotate-90) [475.736975] Starting subtest: y-tiled-16bpp-rotate-90 [475.738705] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [475.967929] [077/131] (562s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [477.485248] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [477.486233] Starting dynamic subtest: pipe-A [477.571423] Dynamic subtest pipe-A: SUCCESS (0.086s) [477.594776] Starting dynamic subtest: pipe-B [477.753872] Dynamic subtest pipe-B: SUCCESS (0.181s) [477.772015] Starting dynamic subtest: pipe-C [477.897097] Dynamic subtest pipe-C: SUCCESS (0.142s) [477.910935] Starting dynamic subtest: pipe-D [478.022534] Dynamic subtest pipe-D: SUCCESS (0.125s) [478.023429] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.538s) [478.290888] [078/131] (560s left) kms_prop_blob (basic) [478.378103] Starting subtest: basic [478.379071] Subtest basic: SUCCESS (0.000s) [478.534939] [079/131] (560s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [478.623032] Starting subtest: y-tiled-to-vebox-x-tiled [478.625005] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [478.902598] [080/131] (559s left) gem_ccs (suspend-resume) [478.989772] Starting subtest: suspend-resume [478.990688] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0 [497.687210] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (4.176s) [497.700673] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0