[61.442552] Initializing watchdogs [61.442616] /dev/watchdog0 [61.461823] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [61.471836] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [61.475627] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.477856] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [61.729383] Starting subtest: dp-mst-lic-type-0-hdcp14 [61.731785] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [61.938675] [002/133] (960s left) core_getversion (all-cards) [61.993999] Starting subtest: all-cards [62.021522] Subtest all-cards: SUCCESS (0.028s) [62.074981] [003/133] (960s left) kms_atomic_interruptible (legacy-dpms) [62.253844] Starting subtest: legacy-dpms [62.254709] Starting dynamic subtest: pipe-A-DP-3 [68.588302] Dynamic subtest pipe-A-DP-3: SUCCESS (6.333s) [68.589143] Subtest legacy-dpms: SUCCESS (6.334s) [68.846506] [004/133] (953s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping) [69.026490] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping [69.031519] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [69.151065] [005/133] (953s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [69.325721] Starting subtest: plane-primary-toggle-with-vblank-wait [69.327559] Starting dynamic subtest: pipe-A-DP-3 [69.553319] Dynamic subtest pipe-A-DP-3: SUCCESS (0.226s) [69.690350] Starting dynamic subtest: pipe-B-DP-3 [69.962556] Dynamic subtest pipe-B-DP-3: SUCCESS (0.281s) [70.069075] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.743s) [70.312723] [006/133] (952s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [70.495513] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [70.497242] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [70.693278] [007/133] (951s left) kms_psr (fbc-psr2-primary-mmap-cpu) [70.870578] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s) [70.937560] [008/133] (951s left) perf (invalid-oa-exponent) [71.335749] Starting subtest: invalid-oa-exponent [71.358960] Subtest invalid-oa-exponent: SUCCESS (0.023s) [71.406926] [009/133] (951s left) gem_eio (create-ext) [71.704123] Starting subtest: create-ext [72.248903] Subtest create-ext: SUCCESS (0.546s) [72.483962] [010/133] (950s left) kms_color (invalid-degamma-lut-sizes) [72.662144] Starting subtest: invalid-degamma-lut-sizes [72.663021] Starting dynamic subtest: pipe-A [72.746566] Dynamic subtest pipe-A: SUCCESS (0.084s) [72.757656] Starting dynamic subtest: pipe-B [72.758657] Dynamic subtest pipe-B: SUCCESS (0.001s) [72.769238] Starting dynamic subtest: pipe-C [72.770190] Dynamic subtest pipe-C: SUCCESS (0.001s) [72.778604] Starting dynamic subtest: pipe-D [72.779501] Dynamic subtest pipe-D: SUCCESS (0.001s) [72.780433] Subtest invalid-degamma-lut-sizes: SUCCESS (0.087s) [73.003411] [011/133] (949s left) gem_softpin (allocator-basic) [73.085179] Starting subtest: allocator-basic [73.310549] Subtest allocator-basic: SUCCESS (0.225s) [73.488809] [012/133] (949s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [73.667096] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [73.726828] [013/133] (949s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [73.920025] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [73.921931] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [74.118199] [014/133] (948s left) kms_psr (pr-primary-render) [74.299318] Subtest pr-primary-render: SKIP (0.000s) [74.360089] [015/133] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [74.548560] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [74.550244] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [74.701670] [016/133] (948s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [74.889779] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [74.942268] [017/133] (948s left) gem_ccs (ctrl-surf-copy) [75.019128] Starting subtest: ctrl-surf-copy [75.020031] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0 [75.075643] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.056s) [75.083972] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0 [75.298095] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.222s) [75.306340] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0 [75.326880] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s) [75.335303] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0 [75.551121] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.224s) [75.559634] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0 [75.579963] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.029s) [75.588373] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0 [75.799041] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.219s) [75.807565] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0 [75.827368] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s) [75.835603] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0 [76.047384] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.219s) [76.048360] Subtest ctrl-surf-copy: SUCCESS (1.028s) [76.230114] [018/133] (946s left) perf (invalid-oa-metric-set-id) [76.445429] Starting subtest: invalid-oa-metric-set-id [76.461431] Subtest invalid-oa-metric-set-id: SUCCESS (0.016s) [76.512202] [019/133] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [76.691256] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [76.692988] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [76.864330] [020/133] (946s left) gem_pxp (create-regular-buffer) [79.457208] Starting subtest: create-regular-buffer [79.460416] Subtest create-regular-buffer: SKIP (0.000s) [79.596885] [021/133] (943s left) gem_eio (in-flight-contexts-10ms) [79.912304] Starting subtest: in-flight-contexts-10ms [93.925436] Subtest in-flight-contexts-10ms: SUCCESS (14.015s) [94.232343] [022/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [94.408533] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [94.410229] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [94.598946] [023/133] (928s left) gem_exec_schedule (u-fairslice-all) [94.679295] Starting subtest: u-fairslice-all [96.795886] Subtest u-fairslice-all: SUCCESS (2.116s) [97.231123] [024/133] (926s left) core_getstats (basic) [97.298938] Starting subtest: basic [97.299876] Subtest basic: SUCCESS (0.000s) [97.426904] [025/133] (926s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [97.599372] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [97.600269] Starting dynamic subtest: pipe-A-DP-3 [97.608706] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [97.617532] Starting dynamic subtest: pipe-B-DP-3 [97.625712] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [97.634454] Starting dynamic subtest: pipe-C-DP-3 [97.642740] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [97.651357] Starting dynamic subtest: pipe-D-DP-3 [97.661332] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [97.663466] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.006s) [98.073275] [026/133] (925s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [98.247182] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [98.248104] Starting dynamic subtest: pipe-A-DP-3 [98.256448] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [98.265324] Starting dynamic subtest: pipe-B-DP-3 [98.273623] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [98.282367] Starting dynamic subtest: pipe-C-DP-3 [98.290294] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [98.299298] Starting dynamic subtest: pipe-D-DP-3 [98.308904] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [98.310745] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s) [98.734393] [027/133] (924s left) sw_sync (alloc_fence) [98.776356] Starting subtest: alloc_fence [98.777248] Subtest alloc_fence: SUCCESS (0.000s) [98.896066] [028/133] (924s left) i915_pm_rps (basic-api) [98.972253] Starting subtest: basic-api [98.974059] Subtest basic-api: SKIP (0.000s) [99.133287] [029/133] (924s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [99.312932] Starting subtest: cursorB-vs-flipA-toggle [99.315846] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s) [99.439468] [030/133] (924s left) kms_cursor_crc (cursor-rapid-movement-128x42) [99.818713] Starting subtest: cursor-rapid-movement-128x42 [99.823169] Starting dynamic subtest: pipe-A-DP-3 [100.271037] Dynamic subtest pipe-A-DP-3: SUCCESS (0.447s) [100.317752] Starting dynamic subtest: pipe-D-DP-3 [100.681913] Dynamic subtest pipe-D-DP-3: SUCCESS (0.372s) [100.682909] Subtest cursor-rapid-movement-128x42: SUCCESS (0.863s) [101.174939] [031/133] (922s left) kms_dp_link_training (non-uhbr-sst) [101.349626] Starting subtest: non-uhbr-sst [103.519809] Subtest non-uhbr-sst: SUCCESS (2.166s) [103.692047] [032/133] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [103.875182] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [103.876868] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [104.073027] [033/133] (919s left) gem_exec_parallel (engines) [104.148585] Starting subtest: engines [104.149500] Starting dynamic subtest: basic [105.727771] Dynamic subtest basic: SUCCESS (1.579s) [105.737423] Starting dynamic subtest: contexts [110.266438] Dynamic subtest contexts: SUCCESS (4.538s) [110.275888] Starting dynamic subtest: fds [113.956742] Dynamic subtest fds: SUCCESS (3.690s) [113.968511] Starting dynamic subtest: userptr [115.430603] Dynamic subtest userptr: SUCCESS (1.474s) [115.431739] Subtest engines: SUCCESS (11.282s) [115.726817] [034/133] (908s left) gem_eio (in-flight-immediate) [116.014911] Starting subtest: in-flight-immediate [121.283253] Subtest in-flight-immediate: SUCCESS (5.269s) [121.571091] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true [121.572740] [035/133] (902s left) prime_mmap (test_forked) [121.646752] Starting subtest: test_forked [121.647595] Starting dynamic subtest: test_forked-smem [121.729318] Dynamic subtest test_forked-smem: SUCCESS (0.082s) [121.738661] Starting dynamic subtest: test_forked-lmem0 [122.078834] Dynamic subtest test_forked-lmem0: SUCCESS (0.349s) [122.079784] Subtest test_forked: SUCCESS (0.432s) [122.219048] [036/133] (902s left) kms_dsc (dsc-with-formats) [122.403363] Starting subtest: dsc-with-formats [122.419161] Subtest dsc-with-formats: SKIP (0.002s) [122.560067] [037/133] (901s left) prime_busy (hang) [122.641131] Starting subtest: hang [122.643109] Starting dynamic subtest: rcs0 [149.490374] Dynamic subtest rcs0: SUCCESS (26.846s) [149.499900] Starting dynamic subtest: bcs0 [156.638205] Dynamic subtest bcs0: SUCCESS (7.147s) [156.647660] Starting dynamic subtest: vcs0 [163.629451] Dynamic subtest vcs0: SUCCESS (6.991s) [163.639157] Starting dynamic subtest: vcs1 [170.657513] Dynamic subtest vcs1: SUCCESS (7.027s) [170.667161] Starting dynamic subtest: vecs0 [177.645939] Dynamic subtest vecs0: SUCCESS (6.989s) [177.655681] Starting dynamic subtest: vecs1 [184.620196] Dynamic subtest vecs1: SUCCESS (6.974s) [184.629846] Starting dynamic subtest: ccs0 [198.503688] Dynamic subtest ccs0: SUCCESS (13.883s) [198.504557] Subtest hang: SUCCESS (75.862s) [198.690318] [038/133] (825s left) kms_vblank (wait-idle) [198.877005] Starting subtest: wait-idle [198.877929] Starting dynamic subtest: pipe-A-DP-3 [201.202320] Dynamic subtest pipe-A-DP-3: SUCCESS (2.324s) [201.229062] Starting dynamic subtest: pipe-D-DP-3 [203.484120] Dynamic subtest pipe-D-DP-3: SUCCESS (2.272s) [203.485290] Subtest wait-idle: SUCCESS (4.607s) [203.751714] [039/133] (820s left) kms_pm_rpm (package-g7) [206.076733] Starting subtest: package-g7 [206.078798] Subtest package-g7: SKIP (0.000s) [206.514824] [040/133] (817s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [206.701051] Starting subtest: flip-vs-cursor-varying-size [218.695169] Subtest flip-vs-cursor-varying-size: SUCCESS (11.994s) [219.018752] [041/133] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [219.204714] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [219.206315] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [219.387826] [042/133] (805s left) syncobj_timeline (single-wait-all-for-submit-signaled) [219.464148] Starting subtest: single-wait-all-for-submit-signaled [219.465278] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [219.634691] [043/133] (805s left) perf (gen12-group-exclusive-stream-ctx-handle) [219.828383] Starting subtest: gen12-group-exclusive-stream-ctx-handle [219.854928] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.027s) [219.904231] [044/133] (804s left) gem_wait (busy) [220.034543] Starting subtest: busy [220.035511] Starting dynamic subtest: all-engines [220.636227] Dynamic subtest all-engines: SUCCESS (0.601s) [220.647025] Starting dynamic subtest: rcs0 [221.174990] Dynamic subtest rcs0: SUCCESS (0.538s) [221.184836] Starting dynamic subtest: bcs0 [221.713080] Dynamic subtest bcs0: SUCCESS (0.537s) [221.722808] Starting dynamic subtest: vcs0 [222.251129] Dynamic subtest vcs0: SUCCESS (0.537s) [222.260973] Starting dynamic subtest: vcs1 [222.788863] Dynamic subtest vcs1: SUCCESS (0.537s) [222.798529] Starting dynamic subtest: vecs0 [223.327326] Dynamic subtest vecs0: SUCCESS (0.538s) [223.337230] Starting dynamic subtest: vecs1 [223.866058] Dynamic subtest vecs1: SUCCESS (0.538s) [223.876005] Starting dynamic subtest: ccs0 [224.405118] Dynamic subtest ccs0: SUCCESS (0.539s) [224.406033] Subtest busy: SUCCESS (4.371s) [224.715058] [045/133] (800s left) gen9_exec_parse (bb-secure) [224.797307] Subtest bb-secure: SKIP (0.000s) [224.894320] [046/133] (799s left) kms_cursor_edge_walk (128x128-right-edge) [225.078992] Starting subtest: 128x128-right-edge [225.079939] Starting dynamic subtest: pipe-A-DP-3 [228.544418] Dynamic subtest pipe-A-DP-3: SUCCESS (3.465s) [228.557133] Starting dynamic subtest: pipe-D-DP-3 [231.872396] Dynamic subtest pipe-D-DP-3: SUCCESS (3.325s) [231.873320] Subtest 128x128-right-edge: SUCCESS (6.793s) [232.202789] [047/133] (792s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [232.398514] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [232.400189] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [232.553521] [048/133] (792s left) prime_mmap (test_forked_cpu_write) [232.627474] Starting subtest: test_forked_cpu_write [232.628407] Starting dynamic subtest: test_forked_cpu_write-smem [232.636059] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s) [232.646191] Starting dynamic subtest: test_forked_cpu_write-lmem0 [232.647165] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.008s) [232.648654] Subtest test_forked_cpu_write: SUCCESS (0.018s) [232.821134] [049/133] (792s left) kms_addfb_basic (small-bo) [233.015129] Starting subtest: small-bo [233.016143] Subtest small-bo: SUCCESS (0.000s) [233.220697] [050/133] (791s left) kms_chamelium_audio (dp-audio) [233.482187] Subtest dp-audio: SKIP (0.000s) [233.633954] [051/133] (791s left) kms_chamelium_edid (hdmi-edid-change-during-suspend) [233.905563] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s) [234.054863] [052/133] (791s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [234.243815] Starting subtest: psr-shrfb-scaledprimary [234.245427] Subtest psr-shrfb-scaledprimary: SKIP (0.000s) [234.433233] [053/133] (790s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [234.615911] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [234.617637] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [234.763696] [054/133] (790s left) perf (i915-ref-count) [234.851634] Starting subtest: i915-ref-count [234.952075] Subtest i915-ref-count: SUCCESS (0.100s) [235.080982] [055/133] (790s left) kms_joiner (invalid-modeset-force-big-joiner) [235.268068] Starting subtest: invalid-modeset-force-big-joiner [235.268843] Starting dynamic subtest: big_joiner_on_last_pipe [235.467409] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.201s) [235.468210] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.201s) [235.765524] [056/133] (789s left) kms_cursor_crc (cursor-alpha-opaque) [235.949172] Starting subtest: cursor-alpha-opaque [235.950055] Starting dynamic subtest: pipe-A-DP-3 [236.529028] Dynamic subtest pipe-A-DP-3: SUCCESS (0.578s) [236.546208] Starting dynamic subtest: pipe-D-DP-3 [237.046932] Dynamic subtest pipe-D-DP-3: SUCCESS (0.516s) [237.047882] Subtest cursor-alpha-opaque: SUCCESS (1.098s) [237.713267] [057/133] (787s left) kms_legacy_colorkey (basic) [237.898429] Starting subtest: basic [237.899296] Starting dynamic subtest: pipe-A [237.962711] Dynamic subtest pipe-A: SUCCESS (0.064s) [237.979155] Starting dynamic subtest: pipe-B [237.980280] Dynamic subtest pipe-B: SUCCESS (0.001s) [237.997734] Starting dynamic subtest: pipe-C [237.999033] Dynamic subtest pipe-C: SUCCESS (0.001s) [238.014346] Starting dynamic subtest: pipe-D [238.015582] Dynamic subtest pipe-D: SUCCESS (0.001s) [238.016728] Subtest basic: SUCCESS (0.069s) [238.169336] [058/133] (787s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip) [238.363530] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip [238.365237] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [238.558647] [059/133] (787s left) kms_addfb_basic (bad-pitch-32) [238.633378] Starting subtest: bad-pitch-32 [238.634228] Subtest bad-pitch-32: SUCCESS (0.000s) [238.892240] [060/133] (787s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [238.974410] Starting subtest: x-tiled-to-vebox-y-tiled [238.976407] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [239.255110] [061/133] (786s left) gem_exec_reloc (basic-range) [239.341412] Subtest basic-range: SKIP (0.000s) [239.454165] [062/133] (786s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [239.649635] Starting subtest: yf-tiled-64bpp-rotate-0 [239.651307] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [239.845216] [063/133] (786s left) syncobj_wait (wait-all-for-submit-snapshot) [239.926434] Starting subtest: wait-all-for-submit-snapshot [240.009459] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [240.128681] [064/133] (786s left) kms_async_flips (invalid-async-flip) [240.320528] Starting subtest: invalid-async-flip [240.540525] Starting dynamic subtest: pipe-A-DP-3 [240.918783] Dynamic subtest pipe-A-DP-3: SUCCESS (0.378s) [241.122797] Starting dynamic subtest: pipe-B-DP-3 [241.280512] Dynamic subtest pipe-B-DP-3: SUCCESS (0.167s) [241.481549] Starting dynamic subtest: pipe-C-DP-3 [241.630805] Dynamic subtest pipe-C-DP-3: SUCCESS (0.159s) [241.829455] Starting dynamic subtest: pipe-D-DP-3 [241.972941] Dynamic subtest pipe-D-DP-3: SUCCESS (0.153s) [241.973907] Subtest invalid-async-flip: SUCCESS (1.652s) [242.474843] [065/133] (783s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [242.661758] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [242.666409] Starting dynamic subtest: A-DP3 [243.608036] Dynamic subtest A-DP3: SUCCESS (0.938s) [243.628405] Starting dynamic subtest: B-DP3 [244.364969] Dynamic subtest B-DP3: SUCCESS (0.756s) [244.375968] Starting dynamic subtest: C-DP3 [245.103616] Dynamic subtest C-DP3: SUCCESS (0.737s) [245.113390] Starting dynamic subtest: D-DP3 [245.854834] Dynamic subtest D-DP3: SUCCESS (0.750s) [245.856251] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.194s) [246.153982] [066/133] (780s left) kms_frontbuffer_tracking (fbc-suspend) [246.347852] Starting subtest: fbc-suspend [287.650648] Subtest fbc-suspend: SUCCESS (10.826s) [287.865390] [067/133] (738s left) syncobj_timeline (invalid-transfer-bad-pad) [287.945484] Starting subtest: invalid-transfer-bad-pad [287.946357] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [288.136291] [068/133] (738s left) kms_big_fb (4-tiled-64bpp-rotate-90) [288.335124] Starting subtest: 4-tiled-64bpp-rotate-90 [288.385278] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.048s) [288.582613] [069/133] (738s left) gem_ctx_persistence (saturated-hostile-nopreempt) [288.669292] Starting subtest: saturated-hostile-nopreempt [288.670288] Starting dynamic subtest: rcs0 [288.760561] Dynamic subtest rcs0: SKIP (0.090s) [288.773041] Starting dynamic subtest: bcs0 [288.774771] Dynamic subtest bcs0: SKIP (0.012s) [288.786200] Starting dynamic subtest: vcs0 [288.788129] Dynamic subtest vcs0: SKIP (0.011s) [288.799504] Starting dynamic subtest: vcs1 [288.806131] Dynamic subtest vcs1: SKIP (0.019s) [288.817937] Starting dynamic subtest: vecs0 [288.821316] Dynamic subtest vecs0: SKIP (0.014s) [288.833107] Starting dynamic subtest: vecs1 [288.835225] Dynamic subtest vecs1: SKIP (0.011s) [288.847227] Starting dynamic subtest: ccs0 [288.849115] Dynamic subtest ccs0: SKIP (0.012s) [288.851100] Subtest saturated-hostile-nopreempt: SKIP (0.176s) [289.049975] [070/133] (737s left) gem_exec_big (single) [289.134955] Starting subtest: single [294.631713] Subtest single: SUCCESS (5.496s) [295.377020] [071/133] (731s left) gem_exec_fence (submit67) [295.623100] Starting subtest: submit67 [295.625043] Subtest submit67: SKIP (0.000s) [296.314860] [072/133] (730s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [296.536050] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [296.537663] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [296.680935] [073/133] (730s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [296.883312] Starting subtest: fbc-rgb101010-draw-mmap-wc [296.885047] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s) [297.032937] [074/133] (729s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [297.219314] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [297.221028] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [297.405817] [075/133] (729s left) i915_drm_fdinfo (busy-idle) [297.480070] Starting subtest: busy-idle [297.480962] Starting dynamic subtest: rcs0 [297.492464] Dynamic subtest rcs0: SKIP (0.011s) [297.504656] Starting dynamic subtest: bcs0 [297.511394] Dynamic subtest bcs0: SKIP (0.018s) [297.524035] Starting dynamic subtest: vcs0 [297.526500] Dynamic subtest vcs0: SKIP (0.000s) [297.538896] Starting dynamic subtest: vcs1 [297.541212] Dynamic subtest vcs1: SKIP (0.000s) [297.553739] Starting dynamic subtest: vecs0 [297.563190] Dynamic subtest vecs0: SKIP (0.000s) [297.575113] Starting dynamic subtest: vecs1 [297.577412] Dynamic subtest vecs1: SKIP (0.000s) [297.592355] Starting dynamic subtest: ccs0 [297.594697] Dynamic subtest ccs0: SKIP (0.000s) [297.596942] Subtest busy-idle: SKIP (0.037s) [297.642940] [076/133] (729s left) kms_psr (psr2-primary-page-flip) [297.834649] Subtest psr2-primary-page-flip: SKIP (0.000s) [297.895458] [077/133] (729s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [298.077506] Starting subtest: cursorA-vs-flipB-atomic [298.079316] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [298.201708] [078/133] (728s left) kms_prop_blob (blob-prop-lifetime) [298.284659] Starting subtest: blob-prop-lifetime [298.300468] Subtest blob-prop-lifetime: SUCCESS (0.015s) [298.496567] [079/133] (728s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [298.682410] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [298.683176] Starting dynamic subtest: pipe-A [300.666649] Dynamic subtest pipe-A: SUCCESS (1.985s) [300.688292] Starting dynamic subtest: pipe-B [302.763309] Dynamic subtest pipe-B: SUCCESS (2.095s) [302.796023] Starting dynamic subtest: pipe-C [303.076055] Dynamic subtest pipe-C: SUCCESS (0.311s) [303.099259] Starting dynamic subtest: pipe-D [303.389275] Dynamic subtest pipe-D: SUCCESS (0.311s) [303.390459] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.709s) [303.741269] [080/133] (723s left) kms_pipe_crc_basic (hang-read-crc) [303.932541] Starting subtest: hang-read-crc [303.933433] Starting dynamic subtest: pipe-A-DP-3 [305.439650] Dynamic subtest pipe-A-DP-3: SUCCESS (1.503s) [305.464982] Starting dynamic subtest: pipe-B-DP-3 [306.858655] Dynamic subtest pipe-B-DP-3: SUCCESS (1.415s) [306.874323] Starting dynamic subtest: pipe-C-DP-3 [308.228613] Dynamic subtest pipe-C-DP-3: SUCCESS (1.367s) [308.245816] Starting dynamic subtest: pipe-D-DP-3 [309.632374] Dynamic subtest pipe-D-DP-3: SUCCESS (1.402s) [309.633361] Subtest hang-read-crc: SUCCESS (5.701s) [309.977666] [081/133] (717s left) kms_selftest (drm_format) [310.041537] Starting subtest: drm_format [310.050587] Starting dynamic subtest: drm_test_format_block_width_invalid [310.181069] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.120s) [310.223760] Starting dynamic subtest: drm_test_format_block_width_one_plane [310.252798] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.076s) [310.270709] Starting dynamic subtest: drm_test_format_block_width_two_plane [310.359223] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.105s) [310.407300] Starting dynamic subtest: drm_test_format_block_width_three_plane [310.446050] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.081s) [310.468642] Starting dynamic subtest: drm_test_format_block_width_tiled [310.535239] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.087s) [310.581354] Starting dynamic subtest: drm_test_format_block_height_invalid [310.609788] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.071s) [310.627705] Starting dynamic subtest: drm_test_format_block_height_one_plane [310.688835] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.076s) [310.733325] Starting dynamic subtest: drm_test_format_block_height_two_plane [310.773363] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.081s) [310.799126] Starting dynamic subtest: drm_test_format_block_height_three_plane [310.864293] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.087s) [310.879209] Starting dynamic subtest: drm_test_format_block_height_tiled [310.938916] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.070s) [310.979524] Starting dynamic subtest: drm_test_format_min_pitch_invalid [311.050342] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.110s) [311.067286] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp [311.127924] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.071s) [311.172775] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp [311.228684] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.098s) [311.274222] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp [311.325058] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.092s) [311.359018] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp [311.424184] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.096s) [311.469071] Starting dynamic subtest: drm_test_format_min_pitch_two_plane [311.514891] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.087s) [311.558445] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp [311.604340] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.085s) [311.620331] Starting dynamic subtest: drm_test_format_min_pitch_tiled [311.683525] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.077s) [311.685129] Subtest drm_format: SUCCESS (1.642s) [311.928661] [082/133] (715s left) gem_close_race (multigpu-basic-process) [312.046447] Starting subtest: multigpu-basic-process [312.048423] Subtest multigpu-basic-process: SKIP (0.000s) [312.375854] [083/133] (715s left) gem_set_tiling_vs_gtt [312.539621] [084/133] (715s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [312.730535] Starting subtest: planes-downscale-factor-0-5-unity-scaling [312.731300] Starting dynamic subtest: pipe-A [312.824752] Dynamic subtest pipe-A: SUCCESS (0.095s) [312.841159] Starting dynamic subtest: pipe-B [313.023261] Dynamic subtest pipe-B: SUCCESS (0.197s) [313.045626] Starting dynamic subtest: pipe-C [313.238077] Dynamic subtest pipe-C: SUCCESS (0.213s) [313.260552] Starting dynamic subtest: pipe-D [313.451219] Dynamic subtest pipe-D: SUCCESS (0.211s) [313.452406] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.722s) [313.816714] [085/133] (713s left) kms_addfb_basic (basic-y-tiled-legacy) [313.898060] Starting subtest: basic-y-tiled-legacy [313.899789] Subtest basic-y-tiled-legacy: SKIP (0.000s) [314.184850] [086/133] (713s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [314.385179] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [315.716085] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.330s) [315.967464] [087/133] (711s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [316.048727] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [316.050739] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [316.282109] [088/133] (711s left) gem_caching (writes) [316.365373] Starting subtest: writes [320.485340] Subtest writes: SUCCESS (4.120s) [320.679113] [089/133] (707s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [320.759665] Starting subtest: etime-multi-wait-for-submit-unsubmitted [320.866456] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s) [321.032532] [090/133] (707s left) kms_flip (wf_vblank-ts-check) [321.218071] Starting subtest: wf_vblank-ts-check [321.222732] Starting dynamic subtest: A-DP3 [329.343726] Dynamic subtest A-DP3: SUCCESS (8.121s) [329.360721] Starting dynamic subtest: B-DP3 [337.399947] Dynamic subtest B-DP3: SUCCESS (8.054s) [337.415242] Starting dynamic subtest: C-DP3 [345.616254] Dynamic subtest C-DP3: SUCCESS (8.215s) [345.631553] Starting dynamic subtest: D-DP3 [353.836599] Dynamic subtest D-DP3: SUCCESS (8.219s) [353.838957] Subtest wf_vblank-ts-check: SUCCESS (32.621s) [354.187517] [091/133] (674s left) gem_lmem_evict (dontneed-evict-race) [357.090508] Starting subtest: dontneed-evict-race [359.218969] Subtest dontneed-evict-race: SUCCESS (2.129s) [361.085710] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [361.086652] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true [361.088645] [092/133] (667s left) gem_mmap_gtt (medium-copy-odd) [362.720190] Subtest medium-copy-odd: SKIP (0.000s) [362.782540] [FACT gem_mmap_gtt (medium-copy-odd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [362.785026] [FACT gem_mmap_gtt (medium-copy-odd)] new: kernel.kmod_is_loaded.i915: true [362.787895] [093/133] (665s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [362.979402] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [362.984410] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [363.113041] [094/133] (665s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [363.302432] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [363.303342] Starting dynamic subtest: pipe-A-DP-3 [363.324986] Dynamic subtest pipe-A-DP-3: SKIP (0.002s) [363.335567] Starting dynamic subtest: pipe-B-DP-3 [363.356863] Dynamic subtest pipe-B-DP-3: SKIP (0.002s) [363.367895] Starting dynamic subtest: pipe-C-DP-3 [363.393365] Dynamic subtest pipe-C-DP-3: SKIP (0.002s) [363.403909] Starting dynamic subtest: pipe-D-DP-3 [363.425662] Dynamic subtest pipe-D-DP-3: SKIP (0.002s) [363.428045] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.014s) [363.752787] [095/133] (664s left) gem_exec_suspend (basic-s0) [363.852783] Starting subtest: basic-S0 [363.853674] Starting dynamic subtest: smem [385.552296] Dynamic subtest smem: SUCCESS (7.067s) [385.565632] Starting dynamic subtest: lmem0 [406.569036] Dynamic subtest lmem0: SUCCESS (7.157s) [406.570085] Subtest basic-S0: SUCCESS (14.227s) [406.851806] [096/133] (621s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [407.046911] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [408.304632] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.256s) [408.518300] [097/133] (620s left) gem_mmap_offset (bad-extensions) [408.597540] Starting subtest: bad-extensions [408.598510] Subtest bad-extensions: SUCCESS (0.000s) [408.769213] [098/133] (619s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [408.955239] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [408.957007] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s) [409.093949] [099/133] (619s left) gem_mmap_gtt (cpuset-big-copy-odd) [409.171070] Subtest cpuset-big-copy-odd: SKIP (0.000s) [409.249802] [100/133] (619s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [409.444009] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [409.445816] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [409.644881] [101/133] (619s left) kms_psr (fbc-psr2-sprite-render) [409.832661] Subtest fbc-psr2-sprite-render: SKIP (0.000s) [409.899721] [102/133] (619s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [410.098050] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [410.099756] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [410.261095] [103/133] (618s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [410.448248] Starting subtest: crc-primary-basic-y-tiled-ccs [410.449130] Starting dynamic subtest: pipe-A-DP-3 [410.457740] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [410.469373] Starting dynamic subtest: pipe-B-DP-3 [410.477969] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [410.489355] Starting dynamic subtest: pipe-C-DP-3 [410.497810] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [410.509444] Starting dynamic subtest: pipe-D-DP-3 [410.520054] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [410.522038] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.009s) [410.915769] [104/133] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [411.104872] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [411.106559] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [411.272058] [105/133] (617s left) api_intel_bb (add-remove-objects) [411.355406] Starting subtest: add-remove-objects [411.385089] Subtest add-remove-objects: SUCCESS (0.031s) [411.582824] [106/133] (617s left) sysfs_heartbeat_interval (nopreempt) [411.673828] Starting subtest: nopreempt [411.674796] Starting dynamic subtest: vecs0 [416.023353] Dynamic subtest vecs0: SUCCESS (4.346s) [416.037883] Starting dynamic subtest: ccs0 [420.331317] Dynamic subtest ccs0: SUCCESS (4.305s) [420.346008] Starting dynamic subtest: vcs0 [424.577104] Dynamic subtest vcs0: SUCCESS (4.243s) [424.589962] Starting dynamic subtest: bcs0 [428.781958] Dynamic subtest bcs0: SUCCESS (4.203s) [428.794216] Starting dynamic subtest: vecs1 [432.997021] Dynamic subtest vecs1: SUCCESS (4.213s) [433.009438] Starting dynamic subtest: rcs0 [437.329175] Dynamic subtest rcs0: SUCCESS (4.330s) [437.342103] Starting dynamic subtest: vcs1 [441.535271] Dynamic subtest vcs1: SUCCESS (4.206s) [441.536241] Subtest nopreempt: SUCCESS (29.856s) [441.680336] [107/133] (587s left) kms_getfb (getfb2-into-addfb2) [441.867234] Starting subtest: getfb2-into-addfb2 [441.868135] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [442.087371] [108/133] (587s left) gem_close (basic) [442.175360] Starting subtest: basic [442.176229] Subtest basic: SUCCESS (0.000s) [442.321824] [109/133] (587s left) gem_exec_schedule (preemptive-hang) [442.521305] Starting subtest: preemptive-hang [442.522275] Starting dynamic subtest: rcs0 [452.098676] Dynamic subtest rcs0: SUCCESS (9.579s) [452.111279] Starting dynamic subtest: bcs0 [461.127538] Dynamic subtest bcs0: SUCCESS (9.028s) [461.140249] Starting dynamic subtest: vcs0 [470.095486] Dynamic subtest vcs0: SUCCESS (8.966s) [470.108031] Starting dynamic subtest: vcs1 [479.113495] Dynamic subtest vcs1: SUCCESS (9.017s) [479.126068] Starting dynamic subtest: vecs0 [488.140292] Dynamic subtest vecs0: SUCCESS (9.025s) [488.152567] Starting dynamic subtest: vecs1 [497.102517] Dynamic subtest vecs1: SUCCESS (8.960s) [497.115229] Starting dynamic subtest: ccs0 [506.115473] Dynamic subtest ccs0: SUCCESS (9.012s) [506.116350] Subtest preemptive-hang: SUCCESS (63.595s) [506.422851] [110/133] (523s left) i915_drm_fdinfo (virtual-busy-idle) [506.490686] Starting subtest: virtual-busy-idle [506.492378] Subtest virtual-busy-idle: SKIP (0.000s) [506.642660] [111/133] (522s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [506.830977] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [506.832733] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [506.997007] [112/133] (522s left) gem_linear_blits (interruptible) [507.272718] Starting subtest: interruptible [514.507800] Subtest interruptible: SUCCESS (7.235s) [514.660431] [113/133] (515s left) gem_ctx_persistence (engines-mixed) [514.799333] Starting subtest: engines-mixed [514.800256] Starting dynamic subtest: rcs0 [514.920134] Dynamic subtest rcs0: SUCCESS (0.120s) [514.937863] Starting dynamic subtest: bcs0 [514.972409] Dynamic subtest bcs0: SUCCESS (0.051s) [515.004075] Starting dynamic subtest: vcs0 [515.052770] Dynamic subtest vcs0: SUCCESS (0.078s) [515.094006] Starting dynamic subtest: vcs1 [515.116110] Dynamic subtest vcs1: SUCCESS (0.060s) [515.136657] Starting dynamic subtest: vecs0 [515.166128] Dynamic subtest vecs0: SUCCESS (0.048s) [515.182481] Starting dynamic subtest: vecs1 [515.215246] Dynamic subtest vecs1: SUCCESS (0.048s) [515.233997] Starting dynamic subtest: ccs0 [515.277569] Dynamic subtest ccs0: SUCCESS (0.061s) [515.278920] Subtest engines-mixed: SUCCESS (0.479s) [515.490672] [114/133] (514s left) perf_pmu (init-wait) [515.559831] Starting subtest: init-wait [515.560803] Starting dynamic subtest: rcs0 [515.563052] Dynamic subtest rcs0: SUCCESS (0.003s) [515.575306] Starting dynamic subtest: bcs0 [515.576233] Dynamic subtest bcs0: SUCCESS (0.000s) [515.588407] Starting dynamic subtest: vcs0 [515.589299] Dynamic subtest vcs0: SUCCESS (0.000s) [515.601648] Starting dynamic subtest: vcs1 [515.602808] Dynamic subtest vcs1: SUCCESS (0.000s) [515.614991] Starting dynamic subtest: vecs0 [515.616215] Dynamic subtest vecs0: SUCCESS (0.000s) [515.628505] Starting dynamic subtest: vecs1 [515.629664] Dynamic subtest vecs1: SUCCESS (0.000s) [515.641966] Starting dynamic subtest: ccs0 [515.642823] Dynamic subtest ccs0: SUCCESS (0.000s) [515.643856] Subtest init-wait: SUCCESS (0.012s) [515.708134] [115/133] (514s left) gem_exec_reloc (basic-gtt-cpu-active) [515.792291] Subtest basic-gtt-cpu-active: SKIP (0.000s) [515.889377] [116/133] (514s left) kms_pm_lpsp (screens-disabled) [517.088228] Starting subtest: screens-disabled [517.090020] Subtest screens-disabled: SKIP (0.000s) [517.274454] [117/133] (512s left) kms_flip (flip-vs-expired-vblank-interruptible) [517.467140] Starting subtest: flip-vs-expired-vblank-interruptible [517.471995] Starting dynamic subtest: A-DP3 [524.249763] Dynamic subtest A-DP3: FAIL (6.595s) [524.262649] Starting dynamic subtest: B-DP3 [531.836120] Dynamic subtest B-DP3: SUCCESS (7.768s) [531.851297] Starting dynamic subtest: C-DP3 [539.588436] Dynamic subtest C-DP3: SUCCESS (7.751s) [539.605150] Starting dynamic subtest: D-DP3 [547.336935] Dynamic subtest D-DP3: SUCCESS (7.746s) [547.345561] Subtest flip-vs-expired-vblank-interruptible: FAIL (29.877s) [547.701424] [118/133] (482s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [547.889620] Starting subtest: psr-1p-primscrn-cur-indfb-move [547.891150] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [548.100470] [119/133] (482s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [548.297162] Starting subtest: plane-all-modeset-transition-internal-panels [548.298902] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s) [548.468980] [120/133] (481s left) gem_userptr_blits (stress-mm) [548.557975] Starting subtest: stress-mm [553.930567] Subtest stress-mm: SUCCESS (5.369s) [554.112726] [121/133] (476s left) syncobj_eventfd (invalid-bad-flags) [554.199046] Starting subtest: invalid-bad-flags [554.200005] Subtest invalid-bad-flags: SUCCESS (0.000s) [554.350806] [122/133] (476s left) kms_addfb_basic (framebuffer-vs-set-tiling) [554.426367] Starting subtest: framebuffer-vs-set-tiling [554.428101] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [554.705665] [123/133] (475s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [554.900745] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [554.902407] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [555.074189] [124/133] (475s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [555.153119] Starting subtest: multi-wait-for-submit-available-submitted-signaled [555.154041] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [555.344110] [125/133] (475s left) kms_flip (2x-modeset-vs-vblank-race) [555.529094] Starting subtest: 2x-modeset-vs-vblank-race [555.543143] Subtest 2x-modeset-vs-vblank-race: SKIP (0.015s) [555.694548] [126/133] (475s left) i915_query (query-regions-garbage-items) [555.771407] Starting subtest: query-regions-garbage-items [555.772284] Subtest query-regions-garbage-items: SUCCESS (0.000s) [555.965536] [127/133] (474s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [556.042060] Subtest flip-primary-invalidate-overlay: SKIP (0.000s) [556.135071] [128/133] (474s left) gem_exec_balancer (full-late) [556.224130] Starting subtest: full-late [558.118062] Subtest full-late: SUCCESS (1.895s) [558.566016] [129/133] (472s left) gem_exec_reloc (basic-write-wc) [558.648016] Subtest basic-write-wc: SKIP (0.000s) [558.766430] [130/133] (472s left) kms_force_connector_basic (force-load-detect) [558.867816] Starting subtest: force-load-detect [558.869651] Subtest force-load-detect: SKIP (0.000s) [559.149877] [131/133] (471s left) kms_chamelium_hpd (hdmi-hpd-fast) [559.463008] Subtest hdmi-hpd-fast: SKIP (0.000s) [559.626932] [132/133] (471s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [559.816423] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [559.818727] Starting dynamic subtest: pipe-A-valid-mode [561.721684] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.901s) [561.723102] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (1.905s) [562.044381] [133/133] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [562.238853] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [562.240538] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [562.428885] Closing watchdogs results: parsing output: 0/ for test: kms_content_protection results: parsing output: 1/ for test: core_getversion results: parsing output: 2/ for test: kms_atomic_interruptible results: parsing output: 3/ for test: kms_plane results: parsing output: 4/ for test: kms_atomic_transition results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_psr results: parsing output: 7/ for test: perf results: parsing output: 8/ for test: gem_eio results: parsing output: 9/ for test: kms_color results: parsing output: 10/ for test: gem_softpin results: parsing output: 11/ for test: kms_psr2_sf results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: kms_psr results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_psr2_sf results: parsing output: 16/ for test: gem_ccs results: parsing output: 17/ for test: perf results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_pxp results: parsing output: 20/ for test: gem_eio results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_exec_schedule results: parsing output: 23/ for test: core_getstats results: parsing output: 24/ for test: kms_ccs results: parsing output: 25/ for test: kms_ccs results: parsing output: 26/ for test: sw_sync results: parsing output: 27/ for test: i915_pm_rps results: parsing output: 28/ for test: kms_cursor_legacy results: parsing output: 29/ for test: kms_cursor_crc results: parsing output: 30/ for test: kms_dp_link_training results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: gem_exec_parallel results: parsing output: 33/ for test: gem_eio results: parsing output: 34/ for test: prime_mmap results: parsing output: 35/ for test: kms_dsc results: parsing output: 36/ for test: prime_busy results: parsing output: 37/ for test: kms_vblank results: parsing output: 38/ for test: kms_pm_rpm results: parsing output: 39/ for test: kms_cursor_legacy results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: syncobj_timeline results: parsing output: 42/ for test: perf results: parsing output: 43/ for test: gem_wait results: parsing output: 44/ for test: gen9_exec_parse results: parsing output: 45/ for test: kms_cursor_edge_walk results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: prime_mmap results: parsing output: 48/ for test: kms_addfb_basic results: parsing output: 49/ for test: kms_chamelium_audio results: parsing output: 50/ for test: kms_chamelium_edid results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_flip_scaled_crc results: parsing output: 53/ for test: perf results: parsing output: 54/ for test: kms_joiner results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: kms_legacy_colorkey results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: gem_render_copy results: parsing output: 60/ for test: gem_exec_reloc results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: syncobj_wait results: parsing output: 63/ for test: kms_async_flips results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: syncobj_timeline results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: gem_ctx_persistence results: parsing output: 69/ for test: gem_exec_big results: parsing output: 70/ for test: gem_exec_fence results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: i915_drm_fdinfo results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: kms_cursor_legacy results: parsing output: 77/ for test: kms_prop_blob results: parsing output: 78/ for test: kms_plane_scaling results: parsing output: 79/ for test: kms_pipe_crc_basic results: parsing output: 80/ for test: kms_selftest results: parsing output: 81/ for test: gem_close_race results: parsing output: 82/ for test: gem_set_tiling_vs_gtt results: parsing output: 83/ for test: kms_plane_scaling results: parsing output: 84/ for test: kms_addfb_basic results: parsing output: 85/ for test: kms_big_fb results: parsing output: 86/ for test: gem_render_copy results: parsing output: 87/ for test: gem_caching results: parsing output: 88/ for test: syncobj_timeline results: parsing output: 89/ for test: kms_flip results: parsing output: 90/ for test: gem_lmem_evict results: parsing output: 91/ for test: gem_mmap_gtt results: parsing output: 92/ for test: kms_plane results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: gem_exec_suspend results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: gem_mmap_offset results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: gem_mmap_gtt results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: kms_psr results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_ccs results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: api_intel_bb results: parsing output: 105/ for test: sysfs_heartbeat_interval results: parsing output: 106/ for test: kms_getfb results: parsing output: 107/ for test: gem_close results: parsing output: 108/ for test: gem_exec_schedule results: parsing output: 109/ for test: i915_drm_fdinfo results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: gem_linear_blits results: parsing output: 112/ for test: gem_ctx_persistence results: parsing output: 113/ for test: perf_pmu results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_pm_lpsp results: parsing output: 116/ for test: kms_flip results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_atomic_transition results: parsing output: 119/ for test: gem_userptr_blits results: parsing output: 120/ for test: syncobj_eventfd results: parsing output: 121/ for test: kms_addfb_basic results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: syncobj_timeline results: parsing output: 124/ for test: kms_flip results: parsing output: 125/ for test: i915_query results: parsing output: 126/ for test: kms_psr_stress_test results: parsing output: 127/ for test: gem_exec_balancer results: parsing output: 128/ for test: gem_exec_reloc results: parsing output: 129/ for test: kms_force_connector_basic results: parsing output: 130/ for test: kms_chamelium_hpd results: parsing output: 131/ for test: kms_flip_scaled_crc results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.