[59.443183] Initializing watchdogs [59.443250] /dev/watchdog0 [59.461983] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [59.472323] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [59.476159] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.478672] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [59.731460] Starting subtest: dp-mst-lic-type-0-hdcp14 [59.734133] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [59.944173] [002/133] (960s left) core_getversion (all-cards) [59.998706] Starting subtest: all-cards [60.025966] Subtest all-cards: SUCCESS (0.028s) [60.072794] [003/133] (960s left) kms_atomic_interruptible (legacy-dpms) [60.249873] Starting subtest: legacy-dpms [60.250708] Starting dynamic subtest: pipe-A-DP-3 [66.573050] Dynamic subtest pipe-A-DP-3: SUCCESS (6.343s) [66.573903] Subtest legacy-dpms: SUCCESS (6.344s) [66.783696] [004/133] (953s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping) [67.169462] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping [67.182111] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [67.714312] [005/133] (952s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [67.976406] Starting subtest: plane-primary-toggle-with-vblank-wait [67.977259] Starting dynamic subtest: pipe-A-DP-3 [68.205618] Dynamic subtest pipe-A-DP-3: SUCCESS (0.228s) [68.341377] Starting dynamic subtest: pipe-B-DP-3 [68.610907] Dynamic subtest pipe-B-DP-3: SUCCESS (0.279s) [68.716943] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.741s) [69.009577] [006/133] (951s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [69.190378] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [69.192054] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [69.353244] [007/133] (951s left) kms_psr (fbc-psr2-primary-mmap-cpu) [69.533606] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s) [69.587462] [008/133] (950s left) perf (invalid-oa-exponent) [69.986799] Starting subtest: invalid-oa-exponent [70.009024] Subtest invalid-oa-exponent: SUCCESS (0.023s) [70.055811] [009/133] (950s left) gem_eio (create-ext) [70.335534] Starting subtest: create-ext [70.838353] Subtest create-ext: SUCCESS (0.504s) [71.080939] [010/133] (949s left) kms_color (invalid-degamma-lut-sizes) [71.261911] Starting subtest: invalid-degamma-lut-sizes [71.262805] Starting dynamic subtest: pipe-A [71.342484] Dynamic subtest pipe-A: SUCCESS (0.081s) [71.352521] Starting dynamic subtest: pipe-B [71.353476] Dynamic subtest pipe-B: SUCCESS (0.001s) [71.363327] Starting dynamic subtest: pipe-C [71.364265] Dynamic subtest pipe-C: SUCCESS (0.001s) [71.372545] Starting dynamic subtest: pipe-D [71.373440] Dynamic subtest pipe-D: SUCCESS (0.001s) [71.374315] Subtest invalid-degamma-lut-sizes: SUCCESS (0.084s) [71.578899] [011/133] (949s left) gem_softpin (allocator-basic) [71.655116] Starting subtest: allocator-basic [71.881125] Subtest allocator-basic: SUCCESS (0.226s) [72.091653] [012/133] (948s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [72.268961] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [72.318473] [013/133] (948s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [72.509626] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [72.511294] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [72.723810] [014/133] (948s left) kms_psr (pr-primary-render) [72.901440] Subtest pr-primary-render: SKIP (0.000s) [72.951631] [015/133] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [73.143557] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [73.145556] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [73.325952] [016/133] (947s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [73.506985] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [73.551703] [017/133] (947s left) gem_ccs (ctrl-surf-copy) [73.633438] Starting subtest: ctrl-surf-copy [73.634399] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0 [73.690775] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.057s) [73.698963] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0 [73.910283] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.219s) [73.918285] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0 [73.938811] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s) [73.948205] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0 [74.165082] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.226s) [74.173247] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0 [74.193829] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s) [74.202411] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0 [74.414217] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.220s) [74.422432] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0 [74.442714] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s) [74.450946] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0 [74.662959] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.220s) [74.664026] Subtest ctrl-surf-copy: SUCCESS (1.030s) [74.825069] [018/133] (946s left) perf (invalid-oa-metric-set-id) [75.063205] Starting subtest: invalid-oa-metric-set-id [75.079491] Subtest invalid-oa-metric-set-id: SUCCESS (0.017s) [75.135787] [019/133] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [75.315226] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [75.316962] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [75.480242] [020/133] (945s left) gem_pxp (create-regular-buffer) [78.073526] Starting subtest: create-regular-buffer [78.075532] Subtest create-regular-buffer: SKIP (0.000s) [78.188028] [021/133] (942s left) gem_eio (in-flight-contexts-10ms) [78.503922] Starting subtest: in-flight-contexts-10ms [91.942454] Subtest in-flight-contexts-10ms: SUCCESS (13.438s) [92.183624] [022/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [92.363319] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [92.364985] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [92.559064] [023/133] (928s left) gem_exec_schedule (u-fairslice-all) [92.639249] Starting subtest: u-fairslice-all [94.755985] Subtest u-fairslice-all: SUCCESS (2.117s) [95.157922] [024/133] (926s left) core_getstats (basic) [95.225930] Starting subtest: basic [95.226837] Subtest basic: SUCCESS (0.000s) [95.407302] [025/133] (926s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [95.583629] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [95.584467] Starting dynamic subtest: pipe-A-DP-3 [95.592450] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [95.601350] Starting dynamic subtest: pipe-B-DP-3 [95.609815] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [95.618860] Starting dynamic subtest: pipe-C-DP-3 [95.626987] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [95.635618] Starting dynamic subtest: pipe-D-DP-3 [95.645516] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [95.647333] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.006s) [96.069556] [026/133] (925s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [96.248355] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [96.249262] Starting dynamic subtest: pipe-A-DP-3 [96.257695] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [96.266581] Starting dynamic subtest: pipe-B-DP-3 [96.274942] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [96.283664] Starting dynamic subtest: pipe-C-DP-3 [96.291733] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [96.300329] Starting dynamic subtest: pipe-D-DP-3 [96.308852] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [96.310255] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s) [96.694292] [027/133] (924s left) sw_sync (alloc_fence) [96.738231] Starting subtest: alloc_fence [96.739182] Subtest alloc_fence: SUCCESS (0.000s) [96.833961] [028/133] (924s left) i915_pm_rps (basic-api) [96.907985] Starting subtest: basic-api [96.910078] Subtest basic-api: SKIP (0.000s) [97.067688] [029/133] (924s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [97.243482] Starting subtest: cursorB-vs-flipA-toggle [97.246228] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s) [97.357744] [030/133] (924s left) kms_cursor_crc (cursor-rapid-movement-128x42) [97.739713] Starting subtest: cursor-rapid-movement-128x42 [97.743907] Starting dynamic subtest: pipe-A-DP-3 [98.198224] Dynamic subtest pipe-A-DP-3: SUCCESS (0.453s) [98.246837] Starting dynamic subtest: pipe-D-DP-3 [98.629411] Dynamic subtest pipe-D-DP-3: SUCCESS (0.390s) [98.630335] Subtest cursor-rapid-movement-128x42: SUCCESS (0.889s) [99.060107] [031/133] (922s left) kms_dp_link_training (non-uhbr-sst) [99.234592] Starting subtest: non-uhbr-sst [101.410780] Subtest non-uhbr-sst: SUCCESS (2.173s) [101.615749] [032/133] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [101.795430] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [101.797048] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [101.958253] [033/133] (919s left) gem_exec_parallel (engines) [102.035437] Starting subtest: engines [102.036340] Starting dynamic subtest: basic [103.730914] Dynamic subtest basic: SUCCESS (1.695s) [103.742600] Starting dynamic subtest: contexts [107.779430] Dynamic subtest contexts: SUCCESS (4.048s) [107.788896] Starting dynamic subtest: fds [112.570781] Dynamic subtest fds: SUCCESS (4.791s) [112.580615] Starting dynamic subtest: userptr [114.072457] Dynamic subtest userptr: SUCCESS (1.502s) [114.073548] Subtest engines: SUCCESS (12.037s) [114.408117] [034/133] (907s left) gem_eio (in-flight-immediate) [114.697204] Starting subtest: in-flight-immediate [119.955389] Subtest in-flight-immediate: SUCCESS (5.259s) [120.187089] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true [120.188951] [035/133] (901s left) prime_mmap (test_forked) [120.265493] Starting subtest: test_forked [120.266299] Starting dynamic subtest: test_forked-smem [120.321290] Dynamic subtest test_forked-smem: SUCCESS (0.056s) [120.330831] Starting dynamic subtest: test_forked-lmem0 [120.518237] Dynamic subtest test_forked-lmem0: SUCCESS (0.196s) [120.519199] Subtest test_forked: SUCCESS (0.253s) [120.665907] [036/133] (901s left) kms_dsc (dsc-with-formats) [120.866757] Starting subtest: dsc-with-formats [120.882372] Subtest dsc-with-formats: SKIP (0.002s) [121.006725] [037/133] (901s left) prime_busy (hang) [121.084189] Starting subtest: hang [121.086172] Starting dynamic subtest: rcs0 [147.510440] Dynamic subtest rcs0: SUCCESS (26.424s) [147.520071] Starting dynamic subtest: bcs0 [154.599288] Dynamic subtest bcs0: SUCCESS (7.089s) [154.608683] Starting dynamic subtest: vcs0 [161.641980] Dynamic subtest vcs0: SUCCESS (7.043s) [161.651368] Starting dynamic subtest: vcs1 [168.612428] Dynamic subtest vcs1: SUCCESS (6.971s) [168.621834] Starting dynamic subtest: vecs0 [175.649926] Dynamic subtest vecs0: SUCCESS (7.038s) [175.659608] Starting dynamic subtest: vecs1 [182.627599] Dynamic subtest vecs1: SUCCESS (6.977s) [182.637171] Starting dynamic subtest: ccs0 [196.471284] Dynamic subtest ccs0: SUCCESS (13.845s) [196.472242] Subtest hang: SUCCESS (75.392s) [196.649527] [038/133] (825s left) kms_vblank (wait-idle) [196.844078] Starting subtest: wait-idle [196.845008] Starting dynamic subtest: pipe-A-DP-3 [199.150284] Dynamic subtest pipe-A-DP-3: SUCCESS (2.305s) [199.165330] Starting dynamic subtest: pipe-D-DP-3 [201.415806] Dynamic subtest pipe-D-DP-3: SUCCESS (2.261s) [201.416971] Subtest wait-idle: SUCCESS (4.573s) [201.667978] [039/133] (820s left) kms_pm_rpm (package-g7) [204.086577] Starting subtest: package-g7 [204.089975] Subtest package-g7: SKIP (0.000s) [204.524040] [040/133] (817s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [204.708149] Starting subtest: flip-vs-cursor-varying-size [216.671297] Subtest flip-vs-cursor-varying-size: SUCCESS (11.963s) [216.976611] [041/133] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [217.174214] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [217.176044] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [217.375283] [042/133] (805s left) syncobj_timeline (single-wait-all-for-submit-signaled) [217.452360] Starting subtest: single-wait-all-for-submit-signaled [217.453246] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [217.627111] [043/133] (805s left) perf (gen12-group-exclusive-stream-ctx-handle) [217.820061] Starting subtest: gen12-group-exclusive-stream-ctx-handle [217.847204] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.027s) [217.893798] [044/133] (804s left) gem_wait (busy) [218.039591] Starting subtest: busy [218.040599] Starting dynamic subtest: all-engines [218.623749] Dynamic subtest all-engines: SUCCESS (0.584s) [218.633893] Starting dynamic subtest: rcs0 [219.162149] Dynamic subtest rcs0: SUCCESS (0.538s) [219.172231] Starting dynamic subtest: bcs0 [219.701953] Dynamic subtest bcs0: SUCCESS (0.539s) [219.711940] Starting dynamic subtest: vcs0 [220.241141] Dynamic subtest vcs0: SUCCESS (0.539s) [220.251288] Starting dynamic subtest: vcs1 [220.781225] Dynamic subtest vcs1: SUCCESS (0.540s) [220.791116] Starting dynamic subtest: vecs0 [221.321120] Dynamic subtest vecs0: SUCCESS (0.539s) [221.331185] Starting dynamic subtest: vecs1 [221.859077] Dynamic subtest vecs1: SUCCESS (0.537s) [221.869143] Starting dynamic subtest: ccs0 [222.396879] Dynamic subtest ccs0: SUCCESS (0.537s) [222.397832] Subtest busy: SUCCESS (4.358s) [222.696330] [045/133] (800s left) gen9_exec_parse (bb-secure) [222.782288] Subtest bb-secure: SKIP (0.000s) [222.857502] [046/133] (799s left) kms_cursor_edge_walk (128x128-right-edge) [223.040427] Starting subtest: 128x128-right-edge [223.042475] Starting dynamic subtest: pipe-A-DP-3 [226.506272] Dynamic subtest pipe-A-DP-3: SUCCESS (3.464s) [226.521428] Starting dynamic subtest: pipe-D-DP-3 [229.833046] Dynamic subtest pipe-D-DP-3: SUCCESS (3.325s) [229.833989] Subtest 128x128-right-edge: SUCCESS (6.793s) [230.124282] [047/133] (792s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [230.323641] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [230.325403] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [230.520375] [048/133] (792s left) prime_mmap (test_forked_cpu_write) [230.592487] Starting subtest: test_forked_cpu_write [230.593340] Starting dynamic subtest: test_forked_cpu_write-smem [230.601155] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s) [230.611264] Starting dynamic subtest: test_forked_cpu_write-lmem0 [230.612171] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.009s) [230.613169] Subtest test_forked_cpu_write: SUCCESS (0.018s) [230.787407] [049/133] (792s left) kms_addfb_basic (small-bo) [230.969972] Starting subtest: small-bo [230.970902] Subtest small-bo: SUCCESS (0.000s) [231.172481] [050/133] (791s left) kms_chamelium_audio (dp-audio) [231.434341] Subtest dp-audio: SKIP (0.000s) [231.584933] [051/133] (791s left) kms_chamelium_edid (hdmi-edid-change-during-suspend) [231.839801] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s) [231.988802] [052/133] (791s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [232.177939] Starting subtest: psr-shrfb-scaledprimary [232.179607] Subtest psr-shrfb-scaledprimary: SKIP (0.000s) [232.380509] [053/133] (790s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [232.567164] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [232.568900] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [232.735942] [054/133] (790s left) perf (i915-ref-count) [232.882722] Starting subtest: i915-ref-count [232.984197] Subtest i915-ref-count: SUCCESS (0.101s) [233.110808] [055/133] (790s left) kms_joiner (invalid-modeset-force-big-joiner) [233.296908] Starting subtest: invalid-modeset-force-big-joiner [233.297639] Starting dynamic subtest: big_joiner_on_last_pipe [233.498447] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.202s) [233.499436] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.203s) [233.788383] [056/133] (789s left) kms_cursor_crc (cursor-alpha-opaque) [233.980272] Starting subtest: cursor-alpha-opaque [233.981194] Starting dynamic subtest: pipe-A-DP-3 [234.571379] Dynamic subtest pipe-A-DP-3: SUCCESS (0.590s) [234.593234] Starting dynamic subtest: pipe-D-DP-3 [235.111214] Dynamic subtest pipe-D-DP-3: SUCCESS (0.537s) [235.112170] Subtest cursor-alpha-opaque: SUCCESS (1.132s) [235.756050] [057/133] (787s left) kms_legacy_colorkey (basic) [235.948922] Starting subtest: basic [235.949827] Starting dynamic subtest: pipe-A [236.004048] Dynamic subtest pipe-A: SUCCESS (0.055s) [236.019160] Starting dynamic subtest: pipe-B [236.020354] Dynamic subtest pipe-B: SUCCESS (0.001s) [236.036489] Starting dynamic subtest: pipe-C [236.037499] Dynamic subtest pipe-C: SUCCESS (0.000s) [236.051876] Starting dynamic subtest: pipe-D [236.052961] Dynamic subtest pipe-D: SUCCESS (0.000s) [236.054108] Subtest basic: SUCCESS (0.060s) [236.186400] [058/133] (787s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip) [236.379258] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip [236.381071] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [236.569274] [059/133] (787s left) kms_addfb_basic (bad-pitch-32) [236.648223] Starting subtest: bad-pitch-32 [236.649137] Subtest bad-pitch-32: SUCCESS (0.000s) [236.927414] [060/133] (786s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [237.009481] Starting subtest: x-tiled-to-vebox-y-tiled [237.011590] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [237.231365] [061/133] (786s left) gem_exec_reloc (basic-range) [237.314517] Subtest basic-range: SKIP (0.000s) [237.383023] [062/133] (786s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [237.577064] Starting subtest: yf-tiled-64bpp-rotate-0 [237.578823] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [237.770562] [063/133] (786s left) syncobj_wait (wait-all-for-submit-snapshot) [237.851298] Starting subtest: wait-all-for-submit-snapshot [237.934354] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [238.116319] [064/133] (786s left) kms_async_flips (invalid-async-flip) [238.303463] Starting subtest: invalid-async-flip [238.538419] Starting dynamic subtest: pipe-A-DP-3 [238.908151] Dynamic subtest pipe-A-DP-3: SUCCESS (0.370s) [239.114437] Starting dynamic subtest: pipe-B-DP-3 [239.271580] Dynamic subtest pipe-B-DP-3: SUCCESS (0.167s) [239.476927] Starting dynamic subtest: pipe-C-DP-3 [239.625621] Dynamic subtest pipe-C-DP-3: SUCCESS (0.159s) [239.826351] Starting dynamic subtest: pipe-D-DP-3 [239.986588] Dynamic subtest pipe-D-DP-3: SUCCESS (0.172s) [239.987667] Subtest invalid-async-flip: SUCCESS (1.684s) [240.493337] [065/133] (783s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [240.683123] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [240.686601] Starting dynamic subtest: A-DP3 [241.626904] Dynamic subtest A-DP3: SUCCESS (0.939s) [241.649246] Starting dynamic subtest: B-DP3 [242.364250] Dynamic subtest B-DP3: SUCCESS (0.734s) [242.383627] Starting dynamic subtest: C-DP3 [243.118463] Dynamic subtest C-DP3: SUCCESS (0.752s) [243.140416] Starting dynamic subtest: D-DP3 [243.848630] Dynamic subtest D-DP3: SUCCESS (0.728s) [243.849431] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.167s) [244.146798] [066/133] (780s left) kms_frontbuffer_tracking (fbc-suspend) [244.342009] Starting subtest: fbc-suspend [286.335246] Subtest fbc-suspend: SUCCESS (10.928s) [286.601650] [067/133] (737s left) syncobj_timeline (invalid-transfer-bad-pad) [286.682687] Starting subtest: invalid-transfer-bad-pad [286.683575] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [286.800770] [068/133] (737s left) kms_big_fb (4-tiled-64bpp-rotate-90) [287.003695] Starting subtest: 4-tiled-64bpp-rotate-90 [287.068949] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.064s) [287.290069] [069/133] (737s left) gem_ctx_persistence (saturated-hostile-nopreempt) [287.374702] Starting subtest: saturated-hostile-nopreempt [287.375590] Starting dynamic subtest: rcs0 [287.477840] Dynamic subtest rcs0: SKIP (0.102s) [287.491579] Starting dynamic subtest: bcs0 [287.493331] Dynamic subtest bcs0: SKIP (0.011s) [287.505144] Starting dynamic subtest: vcs0 [287.507346] Dynamic subtest vcs0: SKIP (0.012s) [287.519406] Starting dynamic subtest: vcs1 [287.521479] Dynamic subtest vcs1: SKIP (0.010s) [287.533530] Starting dynamic subtest: vecs0 [287.535307] Dynamic subtest vecs0: SKIP (0.010s) [287.547274] Starting dynamic subtest: vecs1 [287.549116] Dynamic subtest vecs1: SKIP (0.010s) [287.561135] Starting dynamic subtest: ccs0 [287.563496] Dynamic subtest ccs0: SKIP (0.013s) [287.565471] Subtest saturated-hostile-nopreempt: SKIP (0.175s) [287.721089] [070/133] (736s left) gem_exec_big (single) [287.807843] Starting subtest: single [293.299857] Subtest single: SUCCESS (5.491s) [294.029062] [071/133] (730s left) gem_exec_fence (submit67) [294.315619] Starting subtest: submit67 [294.317352] Subtest submit67: SKIP (0.000s) [295.000248] [072/133] (729s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [295.193371] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [295.195077] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [295.415902] [073/133] (729s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [295.621248] Starting subtest: fbc-rgb101010-draw-mmap-wc [295.622958] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s) [295.765577] [074/133] (729s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [295.954150] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [295.955748] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [296.130810] [075/133] (728s left) i915_drm_fdinfo (busy-idle) [296.207588] Starting subtest: busy-idle [296.208507] Starting dynamic subtest: rcs0 [296.210367] Dynamic subtest rcs0: SKIP (0.000s) [296.223449] Starting dynamic subtest: bcs0 [296.225767] Dynamic subtest bcs0: SKIP (0.000s) [296.238512] Starting dynamic subtest: vcs0 [296.240840] Dynamic subtest vcs0: SKIP (0.000s) [296.253569] Starting dynamic subtest: vcs1 [296.255914] Dynamic subtest vcs1: SKIP (0.000s) [296.268242] Starting dynamic subtest: vecs0 [296.270469] Dynamic subtest vecs0: SKIP (0.000s) [296.282416] Starting dynamic subtest: vecs1 [296.285226] Dynamic subtest vecs1: SKIP (0.000s) [296.298837] Starting dynamic subtest: ccs0 [296.300818] Dynamic subtest ccs0: SKIP (0.012s) [296.302911] Subtest busy-idle: SKIP (0.021s) [296.349781] [076/133] (728s left) kms_psr (psr2-primary-page-flip) [296.533598] Subtest psr2-primary-page-flip: SKIP (0.000s) [296.596863] [077/133] (728s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [296.789747] Starting subtest: cursorA-vs-flipB-atomic [296.791494] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [296.956537] [078/133] (728s left) kms_prop_blob (blob-prop-lifetime) [297.032611] Starting subtest: blob-prop-lifetime [297.048599] Subtest blob-prop-lifetime: SUCCESS (0.015s) [297.247558] [079/133] (727s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [297.434848] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [297.435650] Starting dynamic subtest: pipe-A [299.401004] Dynamic subtest pipe-A: SUCCESS (1.965s) [299.421490] Starting dynamic subtest: pipe-B [301.497301] Dynamic subtest pipe-B: SUCCESS (2.095s) [301.523647] Starting dynamic subtest: pipe-C [301.811398] Dynamic subtest pipe-C: SUCCESS (0.312s) [301.843357] Starting dynamic subtest: pipe-D [302.124126] Dynamic subtest pipe-D: SUCCESS (0.310s) [302.125107] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.690s) [302.461563] [080/133] (722s left) kms_pipe_crc_basic (hang-read-crc) [302.650716] Starting subtest: hang-read-crc [302.651590] Starting dynamic subtest: pipe-A-DP-3 [304.150003] Dynamic subtest pipe-A-DP-3: SUCCESS (1.498s) [304.170938] Starting dynamic subtest: pipe-B-DP-3 [305.521364] Dynamic subtest pipe-B-DP-3: SUCCESS (1.369s) [305.536113] Starting dynamic subtest: pipe-C-DP-3 [306.876960] Dynamic subtest pipe-C-DP-3: SUCCESS (1.354s) [306.894451] Starting dynamic subtest: pipe-D-DP-3 [308.290226] Dynamic subtest pipe-D-DP-3: SUCCESS (1.410s) [308.291087] Subtest hang-read-crc: SUCCESS (5.640s) [308.579131] [081/133] (716s left) kms_selftest (drm_format) [308.643907] Starting subtest: drm_format [308.654230] Starting dynamic subtest: drm_test_format_block_width_invalid [308.754239] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.097s) [308.796806] Starting dynamic subtest: drm_test_format_block_width_one_plane [308.837316] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.081s) [308.860025] Starting dynamic subtest: drm_test_format_block_width_two_plane [308.922392] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.082s) [308.939362] Starting dynamic subtest: drm_test_format_block_width_three_plane [309.008961] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.081s) [309.056731] Starting dynamic subtest: drm_test_format_block_width_tiled [309.091240] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.078s) [309.114009] Starting dynamic subtest: drm_test_format_block_height_invalid [309.163925] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.070s) [309.208192] Starting dynamic subtest: drm_test_format_block_height_one_plane [309.241151] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.074s) [309.259701] Starting dynamic subtest: drm_test_format_block_height_two_plane [309.325155] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.082s) [309.371860] Starting dynamic subtest: drm_test_format_block_height_three_plane [309.417687] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.088s) [309.447946] Starting dynamic subtest: drm_test_format_block_height_tiled [309.481348] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.062s) [309.510525] Starting dynamic subtest: drm_test_format_min_pitch_invalid [309.570059] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.085s) [309.616125] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp [309.652434] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.078s) [309.672698] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp [309.735049] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.081s) [309.781243] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp [309.817173] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.077s) [309.837404] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp [309.893308] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.073s) [309.938606] Starting dynamic subtest: drm_test_format_min_pitch_two_plane [309.986622] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.089s) [310.018712] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp [310.060351] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.071s) [310.104379] Starting dynamic subtest: drm_test_format_min_pitch_tiled [310.148608] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.086s) [310.149731] Subtest drm_format: SUCCESS (1.505s) [310.390698] [082/133] (715s left) gem_close_race (multigpu-basic-process) [310.514814] Starting subtest: multigpu-basic-process [310.517154] Subtest multigpu-basic-process: SKIP (0.000s) [310.808120] [083/133] (714s left) gem_set_tiling_vs_gtt [310.977786] [084/133] (714s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [311.161092] Starting subtest: planes-downscale-factor-0-5-unity-scaling [311.161888] Starting dynamic subtest: pipe-A [311.257052] Dynamic subtest pipe-A: SUCCESS (0.095s) [311.273484] Starting dynamic subtest: pipe-B [311.455372] Dynamic subtest pipe-B: SUCCESS (0.197s) [311.479244] Starting dynamic subtest: pipe-C [311.668199] Dynamic subtest pipe-C: SUCCESS (0.211s) [311.692000] Starting dynamic subtest: pipe-D [311.881263] Dynamic subtest pipe-D: SUCCESS (0.211s) [311.882320] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.721s) [312.228950] [085/133] (713s left) kms_addfb_basic (basic-y-tiled-legacy) [312.308278] Starting subtest: basic-y-tiled-legacy [312.309912] Subtest basic-y-tiled-legacy: SKIP (0.000s) [312.608429] [086/133] (713s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [312.804890] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [314.111567] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.306s) [314.300046] [087/133] (711s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [314.390830] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [314.392716] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [314.679785] [088/133] (711s left) gem_caching (writes) [314.766497] Starting subtest: writes [318.919231] Subtest writes: SUCCESS (4.152s) [319.127268] [089/133] (706s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [319.201840] Starting subtest: etime-multi-wait-for-submit-unsubmitted [319.318625] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s) [319.475062] [090/133] (706s left) kms_flip (wf_vblank-ts-check) [319.664691] Starting subtest: wf_vblank-ts-check [319.669426] Starting dynamic subtest: A-DP3 [327.790595] Dynamic subtest A-DP3: SUCCESS (8.120s) [327.806632] Starting dynamic subtest: B-DP3 [335.841523] Dynamic subtest B-DP3: SUCCESS (8.049s) [335.856865] Starting dynamic subtest: C-DP3 [343.898284] Dynamic subtest C-DP3: SUCCESS (8.055s) [343.913495] Starting dynamic subtest: D-DP3 [351.940388] Dynamic subtest D-DP3: SUCCESS (8.041s) [351.942619] Subtest wf_vblank-ts-check: SUCCESS (32.277s) [352.290203] [091/133] (673s left) gem_lmem_evict (dontneed-evict-race) [355.138260] Starting subtest: dontneed-evict-race [357.241835] Subtest dontneed-evict-race: SUCCESS (2.104s) [359.113909] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [359.114882] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true [359.116805] [092/133] (667s left) gem_mmap_gtt (medium-copy-odd) [360.731138] Subtest medium-copy-odd: SKIP (0.000s) [360.790204] [FACT gem_mmap_gtt (medium-copy-odd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [360.793306] [FACT gem_mmap_gtt (medium-copy-odd)] new: kernel.kmod_is_loaded.i915: true [360.796009] [093/133] (665s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [361.001155] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [361.006174] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [361.184154] [094/133] (665s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [361.371925] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [361.374214] Starting dynamic subtest: pipe-A-DP-3 [361.395388] Dynamic subtest pipe-A-DP-3: SKIP (0.002s) [361.406076] Starting dynamic subtest: pipe-B-DP-3 [361.427443] Dynamic subtest pipe-B-DP-3: SKIP (0.002s) [361.438136] Starting dynamic subtest: pipe-C-DP-3 [361.463247] Dynamic subtest pipe-C-DP-3: SKIP (0.002s) [361.474503] Starting dynamic subtest: pipe-D-DP-3 [361.496430] Dynamic subtest pipe-D-DP-3: SKIP (0.002s) [361.498156] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.014s) [361.862656] [095/133] (664s left) gem_exec_suspend (basic-s0) [361.958623] Starting subtest: basic-S0 [361.959485] Starting dynamic subtest: smem [383.559616] Dynamic subtest smem: SUCCESS (7.207s) [383.572320] Starting dynamic subtest: lmem0 [404.467425] Dynamic subtest lmem0: SUCCESS (7.146s) [404.468221] Subtest basic-S0: SUCCESS (14.355s) [404.762510] [096/133] (621s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [404.959868] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [406.213544] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.281s) [406.461029] [097/133] (620s left) gem_mmap_offset (bad-extensions) [406.533502] Starting subtest: bad-extensions [406.534396] Subtest bad-extensions: SUCCESS (0.000s) [406.717986] [098/133] (619s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [406.936785] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [406.939996] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s) [407.090729] [099/133] (619s left) gem_mmap_gtt (cpuset-big-copy-odd) [407.173114] Subtest cpuset-big-copy-odd: SKIP (0.000s) [407.301372] [100/133] (619s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [407.493922] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [407.495535] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [407.686934] [101/133] (619s left) kms_psr (fbc-psr2-sprite-render) [407.870306] Subtest fbc-psr2-sprite-render: SKIP (0.000s) [407.925139] [102/133] (619s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [408.113966] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [408.115582] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [408.308442] [103/133] (618s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [408.494227] Starting subtest: crc-primary-basic-y-tiled-ccs [408.495053] Starting dynamic subtest: pipe-A-DP-3 [408.503054] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [408.514890] Starting dynamic subtest: pipe-B-DP-3 [408.522939] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [408.534244] Starting dynamic subtest: pipe-C-DP-3 [408.542135] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [408.553310] Starting dynamic subtest: pipe-D-DP-3 [408.562655] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [408.564591] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.009s) [408.990475] [104/133] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [409.180232] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [409.181872] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [409.372993] [105/133] (617s left) api_intel_bb (add-remove-objects) [409.453489] Starting subtest: add-remove-objects [409.484217] Subtest add-remove-objects: SUCCESS (0.032s) [409.716377] [106/133] (617s left) sysfs_heartbeat_interval (nopreempt) [409.798213] Starting subtest: nopreempt [409.800575] Starting dynamic subtest: vecs0 [414.174140] Dynamic subtest vecs0: SUCCESS (4.419s) [414.187467] Starting dynamic subtest: ccs0 [418.453355] Dynamic subtest ccs0: SUCCESS (4.303s) [418.466322] Starting dynamic subtest: vcs0 [422.659116] Dynamic subtest vcs0: SUCCESS (4.220s) [422.674136] Starting dynamic subtest: bcs0 [426.845282] Dynamic subtest bcs0: SUCCESS (4.194s) [426.858230] Starting dynamic subtest: vecs1 [431.079069] Dynamic subtest vecs1: SUCCESS (4.239s) [431.091480] Starting dynamic subtest: rcs0 [435.394907] Dynamic subtest rcs0: SUCCESS (4.316s) [435.410320] Starting dynamic subtest: vcs1 [439.612121] Dynamic subtest vcs1: SUCCESS (4.212s) [439.613013] Subtest nopreempt: SUCCESS (29.912s) [439.783564] [107/133] (587s left) kms_getfb (getfb2-into-addfb2) [439.977268] Starting subtest: getfb2-into-addfb2 [439.978177] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [440.180692] [108/133] (587s left) gem_close (basic) [440.264540] Starting subtest: basic [440.265578] Subtest basic: SUCCESS (0.000s) [440.431408] [109/133] (587s left) gem_exec_schedule (preemptive-hang) [440.633790] Starting subtest: preemptive-hang [440.634689] Starting dynamic subtest: rcs0 [450.558493] Dynamic subtest rcs0: SUCCESS (9.915s) [450.571201] Starting dynamic subtest: bcs0 [459.506575] Dynamic subtest bcs0: SUCCESS (8.952s) [459.519499] Starting dynamic subtest: vcs0 [468.535455] Dynamic subtest vcs0: SUCCESS (9.029s) [468.548195] Starting dynamic subtest: vcs1 [477.572857] Dynamic subtest vcs1: SUCCESS (9.038s) [477.585550] Starting dynamic subtest: vecs0 [486.522592] Dynamic subtest vecs0: SUCCESS (8.951s) [486.535439] Starting dynamic subtest: vecs1 [495.550553] Dynamic subtest vecs1: SUCCESS (9.030s) [495.563216] Starting dynamic subtest: ccs0 [504.567566] Dynamic subtest ccs0: SUCCESS (9.013s) [504.568465] Subtest preemptive-hang: SUCCESS (63.936s) [504.864982] [110/133] (522s left) i915_drm_fdinfo (virtual-busy-idle) [504.933803] Starting subtest: virtual-busy-idle [504.935515] Subtest virtual-busy-idle: SKIP (0.000s) [505.095387] [111/133] (522s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc) [505.286960] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc [505.288646] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [505.481952] [112/133] (522s left) gem_linear_blits (interruptible) [505.741406] Starting subtest: interruptible [512.843582] Subtest interruptible: SUCCESS (7.100s) [513.181620] [113/133] (514s left) gem_ctx_persistence (engines-mixed) [513.305576] Starting subtest: engines-mixed [513.306486] Starting dynamic subtest: rcs0 [513.404412] Dynamic subtest rcs0: SUCCESS (0.098s) [513.421842] Starting dynamic subtest: bcs0 [513.450279] Dynamic subtest bcs0: SUCCESS (0.044s) [513.465948] Starting dynamic subtest: vcs0 [513.512370] Dynamic subtest vcs0: SUCCESS (0.060s) [513.528411] Starting dynamic subtest: vcs1 [513.572573] Dynamic subtest vcs1: SUCCESS (0.058s) [513.602331] Starting dynamic subtest: vecs0 [513.640573] Dynamic subtest vecs0: SUCCESS (0.066s) [513.672380] Starting dynamic subtest: vecs1 [513.697399] Dynamic subtest vecs1: SUCCESS (0.055s) [513.725190] Starting dynamic subtest: ccs0 [513.765155] Dynamic subtest ccs0: SUCCESS (0.065s) [513.769628] Subtest engines-mixed: SUCCESS (0.461s) [513.981078] [114/133] (513s left) perf_pmu (init-wait) [514.051007] Starting subtest: init-wait [514.051969] Starting dynamic subtest: rcs0 [514.054403] Dynamic subtest rcs0: SUCCESS (0.003s) [514.068604] Starting dynamic subtest: bcs0 [514.069478] Dynamic subtest bcs0: SUCCESS (0.000s) [514.082030] Starting dynamic subtest: vcs0 [514.082982] Dynamic subtest vcs0: SUCCESS (0.001s) [514.095676] Starting dynamic subtest: vcs1 [514.096876] Dynamic subtest vcs1: SUCCESS (0.000s) [514.109362] Starting dynamic subtest: vecs0 [514.110658] Dynamic subtest vecs0: SUCCESS (0.000s) [514.123266] Starting dynamic subtest: vecs1 [514.124206] Dynamic subtest vecs1: SUCCESS (0.000s) [514.136843] Starting dynamic subtest: ccs0 [514.138080] Dynamic subtest ccs0: SUCCESS (0.000s) [514.139194] Subtest init-wait: SUCCESS (0.013s) [514.202512] [115/133] (513s left) gem_exec_reloc (basic-gtt-cpu-active) [514.286401] Subtest basic-gtt-cpu-active: SKIP (0.000s) [514.386242] [116/133] (513s left) kms_pm_lpsp (screens-disabled) [515.589370] Starting subtest: screens-disabled [515.591177] Subtest screens-disabled: SKIP (0.000s) [515.728360] [117/133] (512s left) kms_flip (flip-vs-expired-vblank-interruptible) [515.918278] Starting subtest: flip-vs-expired-vblank-interruptible [515.923117] Starting dynamic subtest: A-DP3 [523.782556] Dynamic subtest A-DP3: SUCCESS (7.858s) [523.825992] Starting dynamic subtest: B-DP3 [531.538679] Dynamic subtest B-DP3: SUCCESS (7.751s) [531.553397] Starting dynamic subtest: C-DP3 [539.291363] Dynamic subtest C-DP3: SUCCESS (7.751s) [539.313420] Starting dynamic subtest: D-DP3 [547.048367] Dynamic subtest D-DP3: SUCCESS (7.752s) [547.050596] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (31.131s) [547.381618] [118/133] (480s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [547.572148] Starting subtest: psr-1p-primscrn-cur-indfb-move [547.573847] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [547.763935] [119/133] (480s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [547.950349] Starting subtest: plane-all-modeset-transition-internal-panels [547.952087] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s) [548.127193] [120/133] (480s left) gem_userptr_blits (stress-mm) [548.219684] Starting subtest: stress-mm [553.588187] Subtest stress-mm: SUCCESS (5.369s) [553.804693] [121/133] (474s left) syncobj_eventfd (invalid-bad-flags) [553.889393] Starting subtest: invalid-bad-flags [553.890323] Subtest invalid-bad-flags: SUCCESS (0.000s) [554.022922] [122/133] (474s left) kms_addfb_basic (framebuffer-vs-set-tiling) [554.105697] Starting subtest: framebuffer-vs-set-tiling [554.107471] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [554.383826] [123/133] (474s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [554.571828] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [554.573387] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [554.758049] [124/133] (473s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [554.837293] Starting subtest: multi-wait-for-submit-available-submitted-signaled [554.838244] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [555.022814] [125/133] (473s left) kms_flip (2x-modeset-vs-vblank-race) [555.205301] Starting subtest: 2x-modeset-vs-vblank-race [555.220436] Subtest 2x-modeset-vs-vblank-race: SKIP (0.014s) [555.382859] [126/133] (473s left) i915_query (query-regions-garbage-items) [555.460308] Starting subtest: query-regions-garbage-items [555.461214] Subtest query-regions-garbage-items: SUCCESS (0.000s) [555.681524] [127/133] (473s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [555.763261] Subtest flip-primary-invalidate-overlay: SKIP (0.000s) [555.841545] [128/133] (473s left) gem_exec_balancer (full-late) [555.931797] Starting subtest: full-late [557.814158] Subtest full-late: SUCCESS (1.883s) [558.246322] [129/133] (470s left) gem_exec_reloc (basic-write-wc) [558.328213] Subtest basic-write-wc: SKIP (0.000s) [558.420247] [130/133] (470s left) kms_force_connector_basic (force-load-detect) [558.528312] Starting subtest: force-load-detect [558.530019] Subtest force-load-detect: SKIP (0.000s) [558.827933] [131/133] (470s left) kms_chamelium_hpd (hdmi-hpd-fast) [559.087417] Subtest hdmi-hpd-fast: SKIP (0.000s) [559.239119] [132/133] (470s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [559.424434] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [559.425304] Starting dynamic subtest: pipe-A-valid-mode [561.346823] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.920s) [561.348265] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (1.924s) [561.664563] [133/133] (467s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [561.855097] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [561.856786] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [562.015223] 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.