[62.344175] Initializing watchdogs [62.344224] /dev/watchdog0 [62.359387] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [62.363967] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.366532] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.370184] [001/133] (960s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [62.480895] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [62.485254] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [63.589835] [002/133] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [63.679083] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [63.683635] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [63.781602] [003/133] (959s left) kms_cursor_crc (cursor-tearing-position-change) [63.906718] Starting subtest: cursor-tearing-position-change [63.908670] Starting dynamic subtest: pipe-A-eDP-1 [64.501868] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.594s) [64.510841] Starting dynamic subtest: pipe-D-eDP-1 [65.700991] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.201s) [65.703474] Subtest cursor-tearing-position-change: SUCCESS (1.797s) [66.540925] [004/133] (956s left) kms_async_flips (crc) [66.652617] Starting subtest: crc [67.082834] Starting dynamic subtest: pipe-A-eDP-1 [69.968513] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.866s) [70.335955] Starting dynamic subtest: pipe-B-eDP-1 [73.303696] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.958s) [73.664322] Starting dynamic subtest: pipe-C-eDP-1 [76.618973] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.932s) [76.959395] Starting dynamic subtest: pipe-D-eDP-1 [79.826746] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.875s) [79.829114] Subtest crc: SUCCESS (13.181s) [80.985938] [005/133] (942s left) kms_content_protection (content-type-change) [81.141031] Starting subtest: content-type-change [81.145715] Subtest content-type-change: SKIP (0.000s) [81.270956] [006/133] (941s left) kms_chamelium_hpd (common-hpd-after-suspend) [81.662586] Subtest common-hpd-after-suspend: SKIP (0.000s) [82.488120] [007/133] (940s left) fbdev (eof) [82.528507] Starting subtest: eof [82.530911] Subtest eof: SUCCESS (0.000s) [82.608169] [008/133] (940s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [82.671783] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [82.781061] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.108s) [82.864411] [009/133] (940s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [82.994284] Starting subtest: cursorA-vs-flipA-atomic [94.143097] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.148s) [94.940189] [010/133] (928s left) kms_color_pipeline (plane-ctm3x4-lut1d) [95.040523] Starting subtest: plane-ctm3x4-lut1d [95.208615] Starting dynamic subtest: pipe-A-plane-0 [95.374959] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s) [95.384850] Starting dynamic subtest: pipe-A-plane-1 [95.530592] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s) [95.538746] Starting dynamic subtest: pipe-A-plane-2 [95.707767] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s) [96.958208] Starting dynamic subtest: pipe-B-plane-0 [97.129173] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s) [97.138288] Starting dynamic subtest: pipe-B-plane-1 [97.307740] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s) [97.318093] Starting dynamic subtest: pipe-B-plane-2 [97.473859] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [98.680163] Starting dynamic subtest: pipe-C-plane-0 [98.817473] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [98.824985] Starting dynamic subtest: pipe-C-plane-1 [98.962055] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [98.971095] Starting dynamic subtest: pipe-C-plane-2 [99.128814] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [100.308297] Starting dynamic subtest: pipe-D-plane-0 [100.445670] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [100.457167] Starting dynamic subtest: pipe-D-plane-1 [100.590683] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s) [100.600940] Starting dynamic subtest: pipe-D-plane-2 [100.745781] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [101.032520] Subtest plane-ctm3x4-lut1d: SUCCESS (5.992s) [101.882947] [011/133] (921s left) gem_lmem_swapping (heavy-verify-multi) [101.935324] Subtest heavy-verify-multi: SKIP (0.000s) [101.986256] [012/133] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [102.084364] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [102.088430] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [102.193430] [013/133] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [102.295205] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [102.299477] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [102.391785] [014/133] (920s left) gen3_render_linear_blits [102.516244] [015/133] (920s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [102.615789] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [102.618355] Starting dynamic subtest: pipe-A-eDP-1 [102.682636] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [102.689727] Starting dynamic subtest: pipe-B-eDP-1 [102.746697] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [102.755414] Starting dynamic subtest: pipe-C-eDP-1 [102.812072] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [102.820522] Starting dynamic subtest: pipe-D-eDP-1 [102.867342] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [102.870929] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s) [104.936932] [016/133] (918s left) kms_cursor_crc (cursor-rapid-movement-128x42) [105.153043] Starting subtest: cursor-rapid-movement-128x42 [105.200876] Subtest cursor-rapid-movement-128x42: SKIP (0.043s) [105.410713] [017/133] (918s left) gem_exec_schedule (fifo) [105.474157] Starting subtest: fifo [105.476121] Starting dynamic subtest: rcs0 [105.563629] Dynamic subtest rcs0: SUCCESS (0.099s) [105.574048] Starting dynamic subtest: vcs0 [105.647483] Dynamic subtest vcs0: SUCCESS (0.083s) [105.659976] Starting dynamic subtest: vcs1 [105.730136] Dynamic subtest vcs1: SUCCESS (0.082s) [105.741434] Starting dynamic subtest: vecs0 [105.805724] Dynamic subtest vecs0: SUCCESS (0.075s) [105.818159] Starting dynamic subtest: ccs0 [105.888938] Dynamic subtest ccs0: SUCCESS (0.083s) [105.891202] Subtest fifo: SUCCESS (0.424s) [106.991264] [018/133] (916s left) gem_softpin (noreloc) [107.066805] Starting subtest: noreloc [112.562085] Subtest noreloc: SUCCESS (5.433s) [112.629271] [019/133] (910s left) i915_drm_fdinfo (virtual-busy-hang) [112.670061] Starting subtest: virtual-busy-hang [112.674794] Subtest virtual-busy-hang: SKIP (0.000s) [112.734875] [020/133] (910s left) kms_lease (master-vs-lease) [112.837172] Starting subtest: master-vs-lease [112.839622] Subtest master-vs-lease: SUCCESS (0.001s) [112.939653] [021/133] (910s left) prime_vgem (basic-gtt) [113.075250] Starting subtest: basic-gtt [113.080071] Subtest basic-gtt: SKIP (0.000s) [113.171734] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true [113.175125] [022/133] (910s left) gem_exec_schedule (u-semaphore-resolve) [113.260495] Starting subtest: u-semaphore-resolve [113.290288] Subtest u-semaphore-resolve: SUCCESS (0.036s) [113.640700] [023/133] (910s left) kms_joiner (invalid-modeset-force-big-joiner) [113.743658] Starting subtest: invalid-modeset-force-big-joiner [113.747760] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s) [113.804627] [024/133] (909s left) gem_shrink (reclaim) [113.877351] Starting subtest: reclaim [116.350683] Subtest reclaim: SUCCESS (2.475s) [116.500022] [025/133] (907s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [116.636644] Starting subtest: 2x-cursor-vs-flip-atomic [116.641138] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.003s) [116.800610] [026/133] (907s left) kms_chamelium_frames (hdmi-crc-single) [117.201107] Subtest hdmi-crc-single: SKIP (0.000s) [118.048571] [027/133] (905s left) gem_exec_params (rel-constants-invalid-rel-gen5) [118.114070] Starting subtest: rel-constants-invalid-rel-gen5 [118.116626] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [118.238886] [028/133] (905s left) vgem_basic (dmabuf-mmap) [118.291081] Starting subtest: dmabuf-mmap [118.297364] Subtest dmabuf-mmap: SUCCESS (0.008s) [118.347321] [029/133] (905s left) gem_userptr_blits (readonly-unsync) [118.419329] Subtest readonly-unsync: SKIP (0.000s) [118.553301] [030/133] (905s left) gem_softpin (evict-active) [118.611640] Starting subtest: evict-active [118.616992] Subtest evict-active: SUCCESS (0.005s) [118.729212] [031/133] (905s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [118.829350] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [118.833575] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [118.900662] [032/133] (905s left) kms_pm_backlight (fade) [118.989541] Starting subtest: fade [119.038313] Starting dynamic subtest: eDP-1 [121.539856] Dynamic subtest eDP-1: SUCCESS (2.499s) [121.542292] Subtest fade: SUCCESS (2.550s) [122.402143] [033/133] (901s left) kms_big_fb (y-tiled-16bpp-rotate-270) [122.505084] Starting subtest: y-tiled-16bpp-rotate-270 [122.509542] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [122.612985] [034/133] (901s left) gem_ctx_persistence (smoketest) [122.680051] Starting subtest: smoketest [162.805152] Subtest smoketest: SUCCESS (40.124s) [162.885038] [035/133] (861s left) gem_exec_balancer (sequential) [162.953487] Starting subtest: sequential [166.059503] Subtest sequential: SUCCESS (3.108s) [166.386741] [036/133] (857s left) gem_wait (write-wait) [166.447454] Starting subtest: write-wait [166.450050] Starting dynamic subtest: all-engines [167.551619] Dynamic subtest all-engines: SUCCESS (1.104s) [167.567526] Starting dynamic subtest: rcs0 [168.611055] Dynamic subtest rcs0: SUCCESS (1.058s) [168.627243] Starting dynamic subtest: bcs0 [169.669280] Dynamic subtest bcs0: SUCCESS (1.057s) [169.685347] Starting dynamic subtest: vcs0 [170.723579] Dynamic subtest vcs0: SUCCESS (1.053s) [170.738862] Starting dynamic subtest: vcs1 [171.777077] Dynamic subtest vcs1: SUCCESS (1.052s) [171.792343] Starting dynamic subtest: vecs0 [172.831027] Dynamic subtest vecs0: SUCCESS (1.052s) [172.845852] Starting dynamic subtest: ccs0 [173.886666] Dynamic subtest ccs0: SUCCESS (1.055s) [173.889172] Subtest write-wait: SUCCESS (7.439s) [174.084723] [037/133] (850s left) kms_psr (fbc-psr2-suspend) [174.194198] Starting subtest: fbc-psr2-suspend [174.196578] Starting dynamic subtest: eDP-1 [174.200948] Dynamic subtest eDP-1: SKIP (0.000s) [174.205297] Subtest fbc-psr2-suspend: SKIP (0.001s) [174.267669] [038/133] (850s left) gen9_exec_parse (batch-without-end) [174.323621] Subtest batch-without-end: SKIP (0.000s) [174.396527] [039/133] (849s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [174.506605] Starting subtest: cursor-vs-flip-varying-size [205.911671] Subtest cursor-vs-flip-varying-size: SUCCESS (31.404s) [206.725872] [040/133] (817s left) dmabuf_sync_file (import-multiple-read-only) [206.779225] Starting subtest: import-multiple-read-only [206.781525] Subtest import-multiple-read-only: SUCCESS (0.003s) [206.833442] [041/133] (817s left) prime_mmap (test_map_unmap) [206.894212] Starting subtest: test_map_unmap [206.898534] Starting dynamic subtest: test_map_unmap-smem [206.928254] Dynamic subtest test_map_unmap-smem: SUCCESS (0.036s) [206.932827] Subtest test_map_unmap: SUCCESS (0.036s) [207.045058] [042/133] (817s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [207.137981] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [207.140371] Starting dynamic subtest: pipe-A-default-mode [208.289951] Dynamic subtest pipe-A-default-mode: SKIP (1.150s) [208.294351] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.152s) [208.433909] [043/133] (816s left) kms_plane (pixel-format-linear-modifier-source-clamping) [208.533708] Starting subtest: pixel-format-linear-modifier-source-clamping [208.558152] Starting dynamic subtest: pipe-A-plane-0 [212.080061] Dynamic subtest pipe-A-plane-0: SUCCESS (3.522s) [212.088328] Starting dynamic subtest: pipe-A-plane-3 [213.791232] Dynamic subtest pipe-A-plane-3: SUCCESS (1.709s) [214.851613] Starting dynamic subtest: pipe-B-plane-0 [218.379015] Dynamic subtest pipe-B-plane-0: SUCCESS (3.533s) [218.394515] Starting dynamic subtest: pipe-B-plane-3 [220.022950] Dynamic subtest pipe-B-plane-3: SUCCESS (1.643s) [220.350795] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (11.817s) [221.228378] [044/133] (803s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [221.333605] Starting subtest: psr-2p-scndscrn-cur-indfb-move [221.337689] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [221.439804] [045/133] (803s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [221.491208] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [221.593441] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s) [221.685473] [046/133] (802s left) gem_ctx_shared (q-in-order) [221.740041] Starting subtest: Q-in-order [221.742262] Starting dynamic subtest: rcs0 [221.843448] Dynamic subtest rcs0: SUCCESS (0.103s) [221.855935] Starting dynamic subtest: vcs0 [221.936890] Dynamic subtest vcs0: SUCCESS (0.093s) [221.952784] Starting dynamic subtest: vcs1 [222.019999] Dynamic subtest vcs1: SUCCESS (0.082s) [222.035520] Starting dynamic subtest: vecs0 [222.099549] Dynamic subtest vecs0: SUCCESS (0.078s) [222.116105] Starting dynamic subtest: ccs0 [222.183919] Dynamic subtest ccs0: SUCCESS (0.084s) [222.186873] Subtest Q-in-order: SUCCESS (0.443s) [223.987984] [047/133] (800s left) kms_getfb (getfb-repeated-different-handles) [224.095216] Starting subtest: getfb-repeated-different-handles [224.097516] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [224.189262] [048/133] (800s left) gem_mmap_wc (close) [224.238448] Subtest close: SKIP (0.000s) [224.298148] [049/133] (800s left) drm_read (invalid-buffer) [224.434916] Starting subtest: invalid-buffer [224.437453] Subtest invalid-buffer: SUCCESS (0.000s) [224.551724] [050/133] (800s left) kms_flip (plain-flip-interruptible) [224.641364] Starting subtest: plain-flip-interruptible [224.643689] Starting dynamic subtest: A-eDP1 [226.346685] Dynamic subtest A-eDP1: SUCCESS (1.704s) [226.355769] Starting dynamic subtest: B-eDP1 [227.973876] Dynamic subtest B-eDP1: SUCCESS (1.625s) [227.982923] Starting dynamic subtest: C-eDP1 [229.596121] Dynamic subtest C-eDP1: SUCCESS (1.619s) [229.605682] Starting dynamic subtest: D-eDP1 [231.225076] Dynamic subtest D-eDP1: SUCCESS (1.629s) [231.229875] Subtest plain-flip-interruptible: SUCCESS (6.589s) [232.400115] [051/133] (792s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [232.471814] Starting subtest: yf-tiled-to-vebox-x-tiled [232.476075] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [232.656958] [052/133] (792s left) kms_big_fb (4-tiled-64bpp-rotate-0) [232.763022] Starting subtest: 4-tiled-64bpp-rotate-0 [234.341351] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.579s) [234.522386] [053/133] (790s left) gem_create (create-ext-placement-all) [234.700313] Starting subtest: create-ext-placement-all [234.702465] Subtest create-ext-placement-all: SUCCESS (0.000s) [234.811117] [054/133] (790s left) gem_mmap_offset (partial-unmap) [234.864618] Starting subtest: partial-unmap [234.866659] Starting dynamic subtest: smem0 [235.360909] Dynamic subtest smem0: SUCCESS (0.497s) [235.363465] Subtest partial-unmap: SUCCESS (0.498s) [235.474566] [055/133] (789s left) gem_ctx_isolation (dirty-create) [235.527844] Starting subtest: dirty-create [235.530117] Starting dynamic subtest: rcs0 [235.701820] Dynamic subtest rcs0: SUCCESS (0.174s) [235.711980] Starting dynamic subtest: bcs0 [235.899627] Dynamic subtest bcs0: SUCCESS (0.197s) [235.909752] Starting dynamic subtest: vcs0 [236.107045] Dynamic subtest vcs0: SUCCESS (0.206s) [236.116234] Starting dynamic subtest: vcs1 [238.134224] Dynamic subtest vcs1: SUCCESS (2.026s) [238.144584] Starting dynamic subtest: vecs0 [240.087570] Dynamic subtest vecs0: SUCCESS (1.952s) [240.097295] Starting dynamic subtest: ccs0 [242.148798] Dynamic subtest ccs0: SUCCESS (2.060s) [242.151193] Subtest dirty-create: SUCCESS (6.621s) [242.411482] [056/133] (782s left) api_intel_bb (blit-reloc-purge-cache) [242.472418] Starting subtest: blit-reloc-purge-cache [242.476780] Subtest blit-reloc-purge-cache: SKIP (0.000s) [242.579866] [057/133] (782s left) vgem_basic (bad-fence) [242.618944] Starting subtest: bad-fence [242.621092] Subtest bad-fence: SUCCESS (0.000s) [242.672363] [058/133] (782s left) kms_flip (2x-blocking-absolute-wf_vblank) [242.784193] Starting subtest: 2x-blocking-absolute-wf_vblank [242.793512] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s) [242.871819] [059/133] (782s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [242.981082] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [242.983269] Starting dynamic subtest: pipe-A [243.003124] Dynamic subtest pipe-A: SKIP (0.019s) [243.011108] Starting dynamic subtest: pipe-B [243.037254] Dynamic subtest pipe-B: SKIP (0.032s) [243.051695] Starting dynamic subtest: pipe-C [243.070522] Dynamic subtest pipe-C: SKIP (0.032s) [243.088064] Starting dynamic subtest: pipe-D [243.103102] Dynamic subtest pipe-D: SKIP (0.032s) [243.106940] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.118s) [243.216327] [060/133] (782s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [243.319882] Starting subtest: primary-x-tiled-reflect-x-180 [250.206208] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.889s) [251.362898] [061/133] (773s left) syncobj_timeline (invalid-transfer-illegal-handle) [251.431620] Starting subtest: invalid-transfer-illegal-handle [251.433858] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [251.536766] [062/133] (773s left) kms_psr (fbc-pr-sprite-mmap-gtt) [251.637989] Starting subtest: fbc-pr-sprite-mmap-gtt [251.642331] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [251.712665] [063/133] (773s left) kms_psr (fbc-pr-primary-mmap-cpu) [251.806667] Starting subtest: fbc-pr-primary-mmap-cpu [251.811160] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [251.890188] [064/133] (773s left) gem_exec_nop (basic-parallel) [251.969908] Starting subtest: basic-parallel [267.928231] Subtest basic-parallel: SUCCESS (15.967s) [268.160392] [065/133] (757s left) syncobj_timeline (reset-multiple-signaled) [268.220250] Starting subtest: reset-multiple-signaled [268.222588] Subtest reset-multiple-signaled: SUCCESS (0.001s) [268.318848] [066/133] (757s left) gem_mmap_wc (read-write-distinct) [268.376076] Subtest read-write-distinct: SKIP (0.000s) [268.432050] [067/133] (757s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [268.525741] Starting subtest: plane-downscale-factor-0-75-with-rotation [268.527959] Starting dynamic subtest: pipe-A [268.754254] Dynamic subtest pipe-A: SUCCESS (0.230s) [268.762538] Starting dynamic subtest: pipe-B [270.046267] Dynamic subtest pipe-B: SUCCESS (1.291s) [270.054464] Starting dynamic subtest: pipe-C [271.368626] Dynamic subtest pipe-C: SUCCESS (1.322s) [271.376794] Starting dynamic subtest: pipe-D [272.703269] Dynamic subtest pipe-D: SUCCESS (1.333s) [272.705593] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.180s) [273.910074] [068/133] (751s left) gem_mmap_gtt (cpuset-big-copy-xy) [273.976711] Subtest cpuset-big-copy-XY: SKIP (0.000s) [274.038114] [069/133] (751s left) kms_universal_plane (universal-plane-sanity) [274.130729] Starting subtest: universal-plane-sanity [274.133087] Starting dynamic subtest: pipe-A-eDP-1 [274.732780] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s) [274.742721] Starting dynamic subtest: pipe-B-eDP-1 [275.918502] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.188s) [275.927566] Starting dynamic subtest: pipe-C-eDP-1 [277.126635] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s) [277.135027] Starting dynamic subtest: pipe-D-eDP-1 [278.352834] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s) [278.354938] Subtest universal-plane-sanity: SUCCESS (4.222s) [279.219906] [070/133] (746s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [279.314155] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [279.318809] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [279.420721] [071/133] (746s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [279.530175] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [283.552946] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.026s) [284.712916] [072/133] (741s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [284.818792] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [288.694412] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.879s) [289.825801] [073/133] (735s left) kms_scaling_modes (scaling-mode-full-aspect) [289.914860] Starting subtest: scaling-mode-full-aspect [289.917264] Starting dynamic subtest: pipe-A-eDP-1 [290.008228] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s) [290.017254] Starting dynamic subtest: pipe-B-eDP-1 [291.145843] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.136s) [291.156674] Starting dynamic subtest: pipe-C-eDP-1 [292.261654] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s) [292.272598] Starting dynamic subtest: pipe-D-eDP-1 [293.395784] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s) [293.398094] Subtest scaling-mode-full-aspect: SUCCESS (3.484s) [294.557491] [074/133] (731s left) kms_psr (psr2-sprite-render) [294.656076] Starting subtest: psr2-sprite-render [294.658362] Starting dynamic subtest: eDP-1 [296.348498] Dynamic subtest eDP-1: SUCCESS (1.690s) [296.350494] Subtest psr2-sprite-render: SUCCESS (1.691s) [297.216106] [075/133] (728s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs) [297.307353] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs [297.309719] Starting dynamic subtest: pipe-A-eDP-1 [297.333622] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [297.344294] Starting dynamic subtest: pipe-B-eDP-1 [297.367081] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [297.375203] Starting dynamic subtest: pipe-C-eDP-1 [297.397587] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [297.405438] Starting dynamic subtest: pipe-D-eDP-1 [297.427726] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [297.432233] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s) [299.567738] [076/133] (726s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [299.661105] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [299.665557] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [299.744824] [077/133] (726s left) kms_addfb_basic (bad-pitch-0) [299.800396] Starting subtest: bad-pitch-0 [299.802407] Subtest bad-pitch-0: SUCCESS (0.000s) [299.955500] [078/133] (726s left) gem_workarounds (basic-read) [300.023565] Starting subtest: basic-read [300.035675] Subtest basic-read: SUCCESS (0.010s) [300.142602] [079/133] (725s left) gem_exec_whisper (basic-fds-priority-all) [300.205305] Starting subtest: basic-fds-priority-all [322.244333] Subtest basic-fds-priority-all: SUCCESS (22.038s) [322.446516] [080/133] (703s left) kms_draw_crc (draw-method-mmap-wc) [322.549824] Starting subtest: draw-method-mmap-wc [322.551722] Starting dynamic subtest: xrgb8888-untiled [322.818767] Dynamic subtest xrgb8888-untiled: SUCCESS (0.270s) [322.829205] Starting dynamic subtest: rgb565-untiled [323.052133] Dynamic subtest rgb565-untiled: SUCCESS (0.232s) [323.061739] Starting dynamic subtest: xrgb2101010-untiled [323.263258] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s) [323.271906] Starting dynamic subtest: xbgr16161616f-untiled [323.507213] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s) [323.515618] Starting dynamic subtest: xrgb8888-xtiled [323.652311] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s) [323.660512] Starting dynamic subtest: rgb565-xtiled [323.796089] Dynamic subtest rgb565-xtiled: SUCCESS (0.144s) [323.804191] Starting dynamic subtest: xrgb2101010-xtiled [323.940691] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.144s) [323.948819] Starting dynamic subtest: xbgr16161616f-xtiled [324.073884] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s) [324.084522] Starting dynamic subtest: xrgb8888-4tiled [324.229360] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s) [324.237426] Starting dynamic subtest: rgb565-4tiled [324.385351] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s) [324.394763] Starting dynamic subtest: xrgb2101010-4tiled [324.540788] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s) [324.549219] Starting dynamic subtest: xbgr16161616f-4tiled [324.718417] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s) [324.720347] Subtest draw-method-mmap-wc: SUCCESS (2.171s) [324.824959] [081/133] (701s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [324.922434] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [331.799976] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.879s) [331.937972] [082/133] (694s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [332.037117] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [332.041128] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [332.154198] [083/133] (694s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [332.254879] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [333.090791] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.837s) [333.253499] [084/133] (693s left) core_getstats (basic) [333.304570] Starting subtest: basic [333.306819] Subtest basic: SUCCESS (0.000s) [333.408268] [085/133] (692s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [333.504770] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [340.080051] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.579s) [340.208355] [086/133] (686s left) kms_atomic (atomic-plane-damage) [340.313964] Starting subtest: atomic-plane-damage [340.372069] Starting dynamic subtest: pipe-A-eDP-1 [340.938567] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s) [340.940861] Subtest atomic-plane-damage: SUCCESS (0.625s) [341.772723] [087/133] (684s left) kms_chamelium_color (ctm-max) [341.872769] Subtest ctm-max: SKIP (0.000s) [341.924414] [088/133] (684s left) gem_spin_batch (spin-all-new) [341.992261] Starting subtest: spin-all-new [342.017032] Subtest spin-all-new: SUCCESS (0.025s) [343.982420] [089/133] (682s left) kms_pipe_stress (stress-xrgb8888-ytiled) [344.089367] Starting subtest: stress-xrgb8888-ytiled [344.094233] Subtest stress-xrgb8888-ytiled: SKIP (0.000s) [344.162251] [090/133] (682s left) kms_plane_multiple (2x-tiling-x) [344.242408] Starting subtest: 2x-tiling-x [344.246835] Subtest 2x-tiling-x: SKIP (0.000s) [344.338115] [091/133] (682s left) perf (oa-formats) [344.465969] Starting subtest: oa-formats [344.468278] Starting dynamic subtest: 0-rcs0 [344.483864] Dynamic subtest 0-rcs0: SUCCESS (0.018s) [344.492801] Starting dynamic subtest: 1-vcs1 [344.507337] Dynamic subtest 1-vcs1: SUCCESS (0.023s) [344.509721] Subtest oa-formats: SUCCESS (0.042s) [344.560550] [092/133] (682s left) syncobj_timeline (wait-any-complex) [344.614743] Starting subtest: wait-any-complex [344.677591] Subtest wait-any-complex: SUCCESS (0.062s) [344.755668] [093/133] (681s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [344.843130] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [344.949938] [094/133] (681s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [345.045540] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [345.047338] Starting dynamic subtest: pipe-A-eDP-1 [345.067543] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [345.076955] Starting dynamic subtest: pipe-B-eDP-1 [345.093881] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [345.101900] Starting dynamic subtest: pipe-C-eDP-1 [345.119237] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [345.127127] Starting dynamic subtest: pipe-D-eDP-1 [345.144800] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [345.148154] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s) [347.246475] [095/133] (679s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt) [347.341750] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt [347.345879] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [347.428149] [096/133] (679s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [347.527621] Starting subtest: pr-overlay-plane-update-sf-dmg-area [347.532117] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [347.596770] [097/133] (679s left) gem_exec_fence (syncobj-timeline-invalid-wait) [348.240817] Starting subtest: syncobj-timeline-invalid-wait [348.243971] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [349.990212] [098/133] (676s left) gem_mmap_offset (ptrace) [350.044718] Starting subtest: ptrace [350.047174] Starting dynamic subtest: smem0-wb [350.065154] Dynamic subtest smem0-wb: SUCCESS (0.020s) [350.075755] Starting dynamic subtest: smem0-wc [350.088470] Dynamic subtest smem0-wc: SUCCESS (0.021s) [350.097332] Starting dynamic subtest: smem0-uc [350.109933] Dynamic subtest smem0-uc: SUCCESS (0.021s) [350.112339] Subtest ptrace: SUCCESS (0.068s) [350.230181] [099/133] (676s left) kms_vblank (wait-busy-hang) [350.338249] Starting subtest: wait-busy-hang [350.340115] Starting dynamic subtest: pipe-A-eDP-1 [376.666517] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.327s) [376.690088] Starting dynamic subtest: pipe-D-eDP-1 [401.703693] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.033s) [401.705875] Subtest wait-busy-hang: SUCCESS (51.367s) [402.504444] [100/133] (624s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [402.607894] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [409.401069] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.798s) [409.548837] [101/133] (617s left) kms_big_fb (x-tiled-32bpp-rotate-270) [409.652560] Starting subtest: x-tiled-32bpp-rotate-270 [409.672633] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s) [409.802137] [102/133] (617s left) gem_render_copy (linear-to-vebox-yf-tiled) [409.877408] Starting subtest: linear-to-vebox-yf-tiled [409.881649] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [410.059083] [103/133] (617s left) i915_hangman (gt-engine-hang) [410.131038] Starting subtest: gt-engine-hang [410.133057] Starting dynamic subtest: rcs0 [411.893633] Dynamic subtest rcs0: SUCCESS (1.762s) [411.905440] Starting dynamic subtest: bcs0 [413.877392] Dynamic subtest bcs0: SUCCESS (1.981s) [413.889485] Starting dynamic subtest: vcs0 [415.861654] Dynamic subtest vcs0: SUCCESS (1.981s) [415.873463] Starting dynamic subtest: vcs1 [417.845467] Dynamic subtest vcs1: SUCCESS (1.981s) [417.857671] Starting dynamic subtest: vecs0 [419.894578] Dynamic subtest vecs0: SUCCESS (2.047s) [419.906036] Starting dynamic subtest: ccs0 [421.877477] Dynamic subtest ccs0: SUCCESS (1.980s) [421.880705] Subtest gt-engine-hang: SUCCESS (11.748s) [422.002148] [104/133] (605s left) kms_addfb_basic (bad-pitch-32) [422.051951] Starting subtest: bad-pitch-32 [422.053905] Subtest bad-pitch-32: SUCCESS (0.000s) [422.186699] [105/133] (605s left) perf_pmu (semaphore-busy) [422.225204] Starting subtest: semaphore-busy [422.227507] Starting dynamic subtest: rcs0 [423.870268] Dynamic subtest rcs0: SUCCESS (1.642s) [423.880212] Starting dynamic subtest: bcs0 [425.505187] Dynamic subtest bcs0: SUCCESS (1.631s) [425.518035] Starting dynamic subtest: vcs0 [429.510808] Dynamic subtest vcs0: SUCCESS (3.950s) [429.522138] Starting dynamic subtest: vcs1 [435.411923] Dynamic subtest vcs1: SUCCESS (5.950s) [435.423700] Starting dynamic subtest: vecs0 [441.426404] Dynamic subtest vecs0: SUCCESS (6.012s) [441.438493] Starting dynamic subtest: ccs0 [444.502856] Dynamic subtest ccs0: SUCCESS (3.073s) [444.505837] Subtest semaphore-busy: SUCCESS (22.276s) [444.647266] [106/133] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [444.752388] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [444.756788] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [444.854473] [107/133] (582s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [444.944400] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [444.948682] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [445.051548] [108/133] (582s left) syncobj_timeline (host-signal-ordered) [445.109879] Starting subtest: host-signal-ordered [445.112128] Subtest host-signal-ordered: SUCCESS (0.000s) [445.203783] [109/133] (582s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [445.302657] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [445.306957] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [445.373248] [110/133] (582s left) syncobj_wait (wait-for-submit-complex) [445.433031] Starting subtest: wait-for-submit-complex [445.493828] Subtest wait-for-submit-complex: SUCCESS (0.062s) [445.574207] [111/133] (581s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [445.700744] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [446.713449] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.013s) [446.837152] [112/133] (580s left) gem_readwrite (write-bad-handle) [446.892123] Subtest write-bad-handle: SKIP (0.000s) [446.957362] [113/133] (580s left) i915_pm_rpm (system-suspend-devices) [449.092088] Starting subtest: system-suspend-devices [456.896048] Subtest system-suspend-devices: SUCCESS (7.807s) [457.284811] [114/133] (570s left) kms_psr (fbc-psr-sprite-render) [457.399230] Starting subtest: fbc-psr-sprite-render [457.401588] Starting dynamic subtest: eDP-1 [457.406243] Dynamic subtest eDP-1: SKIP (0.000s) [457.410562] Subtest fbc-psr-sprite-render: SKIP (0.003s) [457.484279] [115/133] (570s left) kms_pm_rpm (modeset-non-lpsp-stress) [459.118612] Starting subtest: modeset-non-lpsp-stress [460.271705] Subtest modeset-non-lpsp-stress: SKIP (1.154s) [460.657323] [116/133] (567s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [460.761529] Starting subtest: 2x-wf_vblank-ts-check-interruptible [460.772815] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [460.851998] [117/133] (566s left) gem_ctx_bad_destroy (invalid-ctx) [460.903869] Starting subtest: invalid-ctx [460.906203] Subtest invalid-ctx: SUCCESS (0.000s) [460.992911] [118/133] (566s left) gem_render_copy_redux (flink-interruptible) [461.045607] Starting subtest: flink-interruptible [461.824611] Subtest flink-interruptible: SUCCESS (0.779s) [461.981806] [119/133] (565s left) gem_exec_reloc (basic-gtt-cpu-active) [462.038769] Subtest basic-gtt-cpu-active: SKIP (0.000s) [462.118852] [120/133] (565s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [462.213060] Starting subtest: fbcpsr-rgb101010-draw-blt [469.031372] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.820s) [469.148440] [121/133] (558s left) i915_selftest (perf) [472.581886] Starting subtest: perf [472.584592] Starting dynamic subtest: engine_cs [476.981946] Dynamic subtest engine_cs: SUCCESS (4.372s) [476.991807] Starting dynamic subtest: request [482.276797] Dynamic subtest request: SUCCESS (5.321s) [482.286787] Starting dynamic subtest: migrate [486.620434] Dynamic subtest migrate: SUCCESS (4.342s) [486.631205] Starting dynamic subtest: region [492.369039] Dynamic subtest region: SUCCESS (5.747s) [492.371887] Subtest perf: SUCCESS (19.788s) [492.400382] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [492.401223] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [492.404371] [122/133] (535s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [494.003452] Starting subtest: short-flip-before-cursor-toggle [494.942044] Subtest short-flip-before-cursor-toggle: SUCCESS (0.936s) [495.789857] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [495.791243] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: kernel.kmod_is_loaded.i915: true [495.795383] [123/133] (532s left) gem_fence_thrash (bo-write-verify-x) [495.846486] Starting subtest: bo-write-verify-x [495.866577] Subtest bo-write-verify-x: SKIP (0.016s) [495.929072] [124/133] (532s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [496.031067] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [496.035173] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [496.123439] [125/133] (531s left) kms_cursor_crc (cursor-offscreen-64x21) [496.315738] Starting subtest: cursor-offscreen-64x21 [496.368702] Subtest cursor-offscreen-64x21: SKIP (0.050s) [496.601114] [126/133] (531s left) perf_pmu (busy-accuracy-2) [496.639679] Starting subtest: busy-accuracy-2 [496.642084] Starting dynamic subtest: rcs0 [499.687736] Dynamic subtest rcs0: SUCCESS (3.045s) [499.698264] Starting dynamic subtest: bcs0 [502.798628] Dynamic subtest bcs0: SUCCESS (3.055s) [502.810429] Starting dynamic subtest: vcs0 [505.842414] Dynamic subtest vcs0: SUCCESS (3.046s) [505.854620] Starting dynamic subtest: vcs1 [508.893529] Dynamic subtest vcs1: SUCCESS (3.049s) [508.904118] Starting dynamic subtest: vecs0 [511.941198] Dynamic subtest vecs0: SUCCESS (3.043s) [511.950506] Starting dynamic subtest: ccs0 [514.999799] Dynamic subtest ccs0: SUCCESS (3.056s) [515.002178] Subtest busy-accuracy-2: SUCCESS (18.309s) [515.076278] [127/133] (513s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [515.176900] Starting subtest: fbc-indfb-scaledprimary [518.106663] Subtest fbc-indfb-scaledprimary: SUCCESS (2.932s) [519.243716] [128/133] (508s left) gem_exec_balancer (hang) [519.524689] Starting subtest: hang [521.177684] Subtest hang: SUCCESS (1.657s) [521.302515] [129/133] (506s left) perf_pmu (busy-idle-no-semaphores) [521.342684] Starting subtest: busy-idle-no-semaphores [521.345162] Starting dynamic subtest: rcs0 [522.003568] Dynamic subtest rcs0: SUCCESS (0.653s) [522.018083] Starting dynamic subtest: bcs0 [522.649785] Dynamic subtest bcs0: SUCCESS (0.651s) [522.661792] Starting dynamic subtest: vcs0 [523.304377] Dynamic subtest vcs0: SUCCESS (0.651s) [523.316368] Starting dynamic subtest: vcs1 [524.542887] Dynamic subtest vcs1: SUCCESS (1.236s) [524.555234] Starting dynamic subtest: vecs0 [526.527354] Dynamic subtest vecs0: SUCCESS (1.982s) [526.539315] Starting dynamic subtest: ccs0 [528.511363] Dynamic subtest ccs0: SUCCESS (1.981s) [528.514101] Subtest busy-idle-no-semaphores: SUCCESS (7.169s) [528.633889] [130/133] (499s left) gem_exec_params (invalid-ring2) [528.696639] Starting subtest: invalid-ring2 [528.698937] Subtest invalid-ring2: SUCCESS (0.000s) [528.797811] [131/133] (499s left) gem_exec_schedule (pi-ringfull) [528.978469] Starting subtest: pi-ringfull [528.980586] Starting dynamic subtest: rcs0 [529.008106] Dynamic subtest rcs0: SUCCESS (0.032s) [529.022017] Starting dynamic subtest: bcs0 [529.040720] Dynamic subtest bcs0: SUCCESS (0.032s) [529.049822] Starting dynamic subtest: vcs0 [529.072866] Dynamic subtest vcs0: SUCCESS (0.031s) [529.082277] Starting dynamic subtest: vcs1 [529.104483] Dynamic subtest vcs1: SUCCESS (0.030s) [529.113994] Starting dynamic subtest: vecs0 [529.135963] Dynamic subtest vecs0: SUCCESS (0.031s) [529.149897] Starting dynamic subtest: ccs0 [529.167053] Dynamic subtest ccs0: SUCCESS (0.030s) [529.169355] Subtest pi-ringfull: SUCCESS (0.193s) [529.398415] [132/133] (498s left) kms_dp_link_training (non-uhbr-sst) [529.497821] Starting subtest: non-uhbr-sst [529.506425] Subtest non-uhbr-sst: SKIP (0.000s) [529.571335] [133/133] (498s left) gem_exec_flush (basic-wb-set-default) [529.638574] Starting subtest: basic-wb-set-default [535.122782] Subtest basic-wb-set-default: SUCCESS (5.459s) [535.295439] Closing watchdogs results: parsing output: 0/ for test: kms_ccs results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_cursor_crc results: parsing output: 3/ for test: kms_async_flips results: parsing output: 4/ for test: kms_content_protection results: parsing output: 5/ for test: kms_chamelium_hpd results: parsing output: 6/ for test: fbdev results: parsing output: 7/ for test: syncobj_timeline results: parsing output: 8/ for test: kms_cursor_legacy results: parsing output: 9/ for test: kms_color_pipeline results: parsing output: 10/ for test: gem_lmem_swapping results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: gen3_render_linear_blits results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: kms_cursor_crc results: parsing output: 16/ for test: gem_exec_schedule results: parsing output: 17/ for test: gem_softpin results: parsing output: 18/ for test: i915_drm_fdinfo results: parsing output: 19/ for test: kms_lease results: parsing output: 20/ for test: prime_vgem results: parsing output: 21/ for test: gem_exec_schedule results: parsing output: 22/ for test: kms_joiner results: parsing output: 23/ for test: gem_shrink results: parsing output: 24/ for test: kms_cursor_legacy results: parsing output: 25/ for test: kms_chamelium_frames results: parsing output: 26/ for test: gem_exec_params results: parsing output: 27/ for test: vgem_basic results: parsing output: 28/ for test: gem_userptr_blits results: parsing output: 29/ for test: gem_softpin results: parsing output: 30/ for test: kms_flip_scaled_crc results: parsing output: 31/ for test: kms_pm_backlight results: parsing output: 32/ for test: kms_big_fb results: parsing output: 33/ for test: gem_ctx_persistence results: parsing output: 34/ for test: gem_exec_balancer results: parsing output: 35/ for test: gem_wait results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: gen9_exec_parse results: parsing output: 38/ for test: kms_cursor_legacy results: parsing output: 39/ for test: dmabuf_sync_file results: parsing output: 40/ for test: prime_mmap results: parsing output: 41/ for test: kms_flip_scaled_crc results: parsing output: 42/ for test: kms_plane results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: syncobj_wait results: parsing output: 45/ for test: gem_ctx_shared results: parsing output: 46/ for test: kms_getfb results: parsing output: 47/ for test: gem_mmap_wc results: parsing output: 48/ for test: drm_read results: parsing output: 49/ for test: kms_flip results: parsing output: 50/ for test: gem_render_copy results: parsing output: 51/ for test: kms_big_fb results: parsing output: 52/ for test: gem_create results: parsing output: 53/ for test: gem_mmap_offset results: parsing output: 54/ for test: gem_ctx_isolation results: parsing output: 55/ for test: api_intel_bb results: parsing output: 56/ for test: vgem_basic results: parsing output: 57/ for test: kms_flip results: parsing output: 58/ for test: kms_plane_scaling results: parsing output: 59/ for test: kms_rotation_crc results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_psr results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: gem_exec_nop results: parsing output: 64/ for test: syncobj_timeline results: parsing output: 65/ for test: gem_mmap_wc results: parsing output: 66/ for test: kms_plane_scaling results: parsing output: 67/ for test: gem_mmap_gtt results: parsing output: 68/ for test: kms_universal_plane results: parsing output: 69/ for test: kms_big_fb results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_scaling_modes results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: kms_ccs results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: gem_workarounds results: parsing output: 78/ for test: gem_exec_whisper results: parsing output: 79/ for test: kms_draw_crc results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: core_getstats results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_atomic results: parsing output: 86/ for test: kms_chamelium_color results: parsing output: 87/ for test: gem_spin_batch results: parsing output: 88/ for test: kms_pipe_stress results: parsing output: 89/ for test: kms_plane_multiple results: parsing output: 90/ for test: perf results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: kms_addfb_basic results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_psr2_sf results: parsing output: 96/ for test: gem_exec_fence results: parsing output: 97/ for test: gem_mmap_offset results: parsing output: 98/ for test: kms_vblank results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_big_fb results: parsing output: 101/ for test: gem_render_copy results: parsing output: 102/ for test: i915_hangman results: parsing output: 103/ for test: kms_addfb_basic results: parsing output: 104/ for test: perf_pmu results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: syncobj_timeline results: parsing output: 108/ for test: kms_psr2_sf results: parsing output: 109/ for test: syncobj_wait results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: gem_readwrite results: parsing output: 112/ for test: i915_pm_rpm results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: kms_pm_rpm results: parsing output: 115/ for test: kms_flip results: parsing output: 116/ for test: gem_ctx_bad_destroy results: parsing output: 117/ for test: gem_render_copy_redux results: parsing output: 118/ for test: gem_exec_reloc results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: i915_selftest results: parsing output: 121/ for test: kms_cursor_legacy results: parsing output: 122/ for test: gem_fence_thrash results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: perf_pmu results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: gem_exec_balancer results: parsing output: 128/ for test: perf_pmu results: parsing output: 129/ for test: gem_exec_params results: parsing output: 130/ for test: gem_exec_schedule results: parsing output: 131/ for test: kms_dp_link_training results: parsing output: 132/ for test: gem_exec_flush Done.