[61.446845] Initializing watchdogs [61.446895] /dev/watchdog0 [61.462135] [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] [61.466596] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.468875] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.470855] [001/133] (960s left) dumb_buffer (create-valid-dumb) [61.534114] Starting subtest: create-valid-dumb [61.535182] Subtest create-valid-dumb: SUCCESS (0.000s) [61.632189] [002/133] (960s left) gem_basic (create-fd-close) [61.694203] Starting subtest: create-fd-close [61.696147] Subtest create-fd-close: SUCCESS (0.000s) [61.808029] [003/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [61.898981] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [65.835473] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.937s) [67.095011] [004/133] (955s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip) [67.271220] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip [67.273597] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [67.472167] [005/133] (954s left) gem_exec_async (concurrent-writes) [67.565907] Starting subtest: concurrent-writes [67.567339] Starting dynamic subtest: rcs0 [67.583804] Dynamic subtest rcs0: SUCCESS (0.020s) [67.593117] Starting dynamic subtest: bcs0 [67.594139] Dynamic subtest bcs0: SUCCESS (0.010s) [67.600708] Starting dynamic subtest: vcs0 [67.603423] Dynamic subtest vcs0: SUCCESS (0.009s) [67.610711] Starting dynamic subtest: vcs1 [67.613158] Dynamic subtest vcs1: SUCCESS (0.009s) [67.619792] Starting dynamic subtest: vecs0 [67.623189] Dynamic subtest vecs0: SUCCESS (0.009s) [67.633763] Starting dynamic subtest: ccs0 [67.634708] Dynamic subtest ccs0: SUCCESS (0.007s) [67.635635] Subtest concurrent-writes: SUCCESS (0.067s) [67.971399] [006/133] (954s left) syncobj_wait (reset-multiple-signaled) [68.136152] Starting subtest: reset-multiple-signaled [68.137133] Subtest reset-multiple-signaled: SUCCESS (0.001s) [68.232282] [007/133] (954s left) i915_query (query-topology-known-pci-ids) [68.284076] Starting subtest: query-topology-known-pci-ids [68.285849] Subtest query-topology-known-pci-ids: SKIP (0.000s) [68.384219] [008/133] (953s left) kms_vblank (invalid) [68.466598] Starting subtest: invalid [68.467546] Starting dynamic subtest: pipe-A-eDP-1 [68.867926] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.402s) [68.868796] Subtest invalid: SUCCESS (0.403s) [69.669498] [009/133] (952s left) core_auth (getclient-simple) [69.699285] Starting subtest: getclient-simple [69.713366] Subtest getclient-simple: SUCCESS (0.014s) [69.803277] [010/133] (952s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [69.910374] Starting subtest: cursorA-vs-flipB-toggle [69.912243] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [70.046707] [011/133] (952s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [70.137485] Starting subtest: yf-tiled-8bpp-rotate-0 [70.139233] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [70.212526] [012/133] (952s left) kms_async_flips (test-cursor) [70.300716] Starting subtest: test-cursor [70.684737] Starting dynamic subtest: pipe-A-eDP-1 [71.461811] Dynamic subtest pipe-A-eDP-1: SKIP (0.776s) [71.852931] Starting dynamic subtest: pipe-B-eDP-1 [72.589974] Dynamic subtest pipe-B-eDP-1: SKIP (0.746s) [72.962674] Starting dynamic subtest: pipe-C-eDP-1 [73.713929] Dynamic subtest pipe-C-eDP-1: SKIP (0.758s) [74.073541] Starting dynamic subtest: pipe-D-eDP-1 [74.845299] Dynamic subtest pipe-D-eDP-1: SKIP (0.777s) [74.847280] Subtest test-cursor: SKIP (4.545s) [76.020415] [013/133] (946s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [76.133702] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [76.135426] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [76.223546] [014/133] (946s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render) [76.305642] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render [83.296260] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.982s) [83.416636] [015/133] (939s left) kms_dither (fb-8bpc-vs-panel-6bpc) [83.511802] Starting subtest: fb-8bpc-vs-panel-6bpc [83.512634] Starting dynamic subtest: pipe-A-eDP-1 [84.947078] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.433s) [84.947940] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.435s) [85.735197] [016/133] (936s left) kms_cursor_edge_walk (256x256-top-edge) [85.842342] Starting subtest: 256x256-top-edge [85.843333] Starting dynamic subtest: pipe-A-eDP-1 [89.311479] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s) [89.318384] Starting dynamic subtest: pipe-D-eDP-1 [92.437278] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s) [92.438033] Subtest 256x256-top-edge: SUCCESS (6.595s) [93.235238] [017/133] (929s left) kms_chamelium_hpd (dp-hpd) [93.616330] Subtest dp-hpd: SKIP (0.000s) [94.439227] [018/133] (928s left) kms_chamelium_color (ctm-negative) [94.531222] Subtest ctm-negative: SKIP (0.000s) [94.567622] [019/133] (928s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [94.651451] Starting subtest: compare-crc-sanitycheck-nv12 [94.652389] Starting dynamic subtest: pipe-A-eDP-1 [95.372464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s) [95.379293] Starting dynamic subtest: pipe-B-eDP-1 [96.671335] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.296s) [96.679333] Starting dynamic subtest: pipe-C-eDP-1 [97.933880] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.263s) [97.941408] Starting dynamic subtest: pipe-D-eDP-1 [99.166892] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s) [99.167845] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.517s) [100.025336] [020/133] (922s left) kms_plane_cursor (viewport) [100.129331] Starting subtest: viewport [100.131330] Starting dynamic subtest: pipe-A-eDP-1-size-64 [102.726338] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.598s) [102.786059] Starting dynamic subtest: pipe-A-eDP-1-size-128 [105.271732] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.494s) [105.331819] Starting dynamic subtest: pipe-A-eDP-1-size-256 [107.850833] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.527s) [108.201348] Starting dynamic subtest: pipe-B-eDP-1-size-64 [111.476068] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.281s) [111.536768] Starting dynamic subtest: pipe-B-eDP-1-size-128 [114.032358] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.504s) [114.092443] Starting dynamic subtest: pipe-B-eDP-1-size-256 [116.600334] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.516s) [116.962821] Starting dynamic subtest: pipe-C-eDP-1-size-64 [119.799502] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.844s) [119.835980] Starting dynamic subtest: pipe-C-eDP-1-size-128 [122.055265] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.225s) [122.092548] Starting dynamic subtest: pipe-C-eDP-1-size-256 [124.288541] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s) [124.621960] Starting dynamic subtest: pipe-D-eDP-1-size-64 [127.485824] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.872s) [127.523544] Starting dynamic subtest: pipe-D-eDP-1-size-128 [129.663479] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.147s) [129.701044] Starting dynamic subtest: pipe-D-eDP-1-size-256 [131.819393] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.125s) [132.136384] Subtest viewport: SUCCESS (32.008s) [132.934998] [021/133] (889s left) prime_self_import (basic-with_one_bo_two_files) [132.963943] Starting subtest: basic-with_one_bo_two_files [132.992227] Subtest basic-with_one_bo_two_files: SUCCESS (0.029s) [133.093126] [022/133] (889s left) gem_lmem_swapping (verify-random-ccs) [133.132532] Subtest verify-random-ccs: SKIP (0.000s) [133.167457] [023/133] (889s left) kms_rotation_crc (sprite-rotation-90) [133.258322] Starting subtest: sprite-rotation-90 [133.259960] Subtest sprite-rotation-90: SKIP (0.001s) [133.323116] [024/133] (889s left) i915_pm_rps (min-max-config-loaded) [133.376605] Starting subtest: min-max-config-loaded [133.378524] Subtest min-max-config-loaded: SKIP (0.001s) [133.460678] [025/133] (889s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [133.537456] Starting subtest: plane-upscale-20x20-with-rotation [133.538328] Starting dynamic subtest: pipe-A [133.763113] Dynamic subtest pipe-A: SUCCESS (0.226s) [133.770717] Starting dynamic subtest: pipe-B [135.026986] Dynamic subtest pipe-B: SUCCESS (1.262s) [135.033509] Starting dynamic subtest: pipe-C [136.360751] Dynamic subtest pipe-C: SUCCESS (1.332s) [136.371070] Starting dynamic subtest: pipe-D [137.690875] Dynamic subtest pipe-D: SUCCESS (1.329s) [137.691955] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.155s) [138.869376] [026/133] (884s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [138.969442] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [138.971225] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [139.054851] [027/133] (883s left) gem_ctx_param (invalid-get-engines) [139.096518] Starting subtest: invalid-get-engines [139.097568] Subtest invalid-get-engines: SUCCESS (0.001s) [139.165039] [028/133] (883s left) gem_exec_schedule (lateslice) [139.234581] Starting subtest: lateslice [139.235566] Starting dynamic subtest: rcs0 [139.256300] Dynamic subtest rcs0: SUCCESS (0.021s) [139.264626] Starting dynamic subtest: bcs0 [139.274906] Dynamic subtest bcs0: SUCCESS (0.017s) [139.281033] Starting dynamic subtest: vcs0 [139.292489] Dynamic subtest vcs0: SUCCESS (0.017s) [139.298709] Starting dynamic subtest: vcs1 [139.314175] Dynamic subtest vcs1: SUCCESS (0.021s) [139.322700] Starting dynamic subtest: vecs0 [139.336839] Dynamic subtest vecs0: SUCCESS (0.022s) [139.343164] Starting dynamic subtest: ccs0 [139.354126] Dynamic subtest ccs0: SUCCESS (0.017s) [139.354961] Subtest lateslice: SUCCESS (0.120s) [140.968153] [029/133] (881s left) gem_eio (in-flight-contexts-immediate) [141.198342] Starting subtest: in-flight-contexts-immediate [154.913800] Subtest in-flight-contexts-immediate: SUCCESS (13.715s) [155.072056] [030/133] (867s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [155.158347] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [162.528311] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.370s) [162.648286] [031/133] (860s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [162.744380] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [163.425986] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s) [163.568398] [032/133] (859s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [163.665577] Starting subtest: psr-farfromfence-mmap-gtt [163.667345] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [163.762842] [033/133] (859s left) kms_psr (psr2-no-drrs) [163.853856] Starting subtest: psr2-no-drrs [163.856247] Starting dynamic subtest: eDP-1 [165.471742] Dynamic subtest eDP-1: SUCCESS (1.614s) [165.472650] Subtest psr2-no-drrs: SUCCESS (1.617s) [166.263130] [034/133] (856s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [166.351365] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [166.353206] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [166.445474] [035/133] (856s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move) [166.534907] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move [174.180771] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.646s) [174.310887] [036/133] (848s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [174.398163] Starting subtest: async-flip-with-page-flip-events-tiled [174.787474] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [177.594767] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.798s) [177.601781] Starting dynamic subtest: pipe-A-eDP-1-4 [179.770055] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s) [179.777574] Starting dynamic subtest: pipe-A-eDP-1-4 [181.779351] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [181.786529] Starting dynamic subtest: pipe-A-eDP-1-x [183.981147] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s) [184.341087] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [187.121216] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.777s) [187.128186] Starting dynamic subtest: pipe-B-eDP-1-4 [189.296522] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s) [189.304848] Starting dynamic subtest: pipe-B-eDP-1-4 [191.306521] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.007s) [191.313721] Starting dynamic subtest: pipe-B-eDP-1-x [193.497232] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [193.856798] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [196.656187] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.800s) [196.663501] Starting dynamic subtest: pipe-C-eDP-1-4 [198.831499] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [198.838831] Starting dynamic subtest: pipe-C-eDP-1-4 [200.841846] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [200.850331] Starting dynamic subtest: pipe-C-eDP-1-x [203.020527] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s) [203.378336] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [206.184071] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.802s) [206.195076] Starting dynamic subtest: pipe-D-eDP-1-4 [208.358590] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s) [208.367815] Starting dynamic subtest: pipe-D-eDP-1-4 [210.369033] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [210.379344] Starting dynamic subtest: pipe-D-eDP-1-x [212.558314] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s) [212.559548] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.150s) [213.762463] [037/133] (809s left) gem_mmap_wc (coherency) [213.815707] Subtest coherency: SKIP (0.000s) [213.879868] [038/133] (809s left) perf (global-sseu-config) [213.994815] Starting subtest: global-sseu-config [213.996511] Subtest global-sseu-config: SKIP (0.000s) [214.035611] [039/133] (809s left) kms_prop_blob (blob-prop-core) [214.093751] Starting subtest: blob-prop-core [214.094743] Subtest blob-prop-core: SUCCESS (0.000s) [214.186201] [040/133] (809s left) perf (per-context-mode-unprivileged) [214.285297] Starting subtest: per-context-mode-unprivileged [214.287242] Subtest per-context-mode-unprivileged: SKIP (0.000s) [214.329026] [041/133] (809s left) prime_mmap (test_forked_cpu_write) [214.383393] Starting subtest: test_forked_cpu_write [214.384342] Starting dynamic subtest: test_forked_cpu_write-smem [214.391726] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s) [214.392625] Subtest test_forked_cpu_write: SUCCESS (0.009s) [214.501568] [042/133] (808s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [214.596587] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [218.625800] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.029s) [219.759449] [043/133] (803s left) kms_psr (fbc-pr-no-drrs) [219.847219] Starting subtest: fbc-pr-no-drrs [219.848907] Subtest fbc-pr-no-drrs: SKIP (0.000s) [219.913193] [044/133] (803s left) kms_psr (fbc-pr-sprite-blt) [220.007623] Starting subtest: fbc-pr-sprite-blt [220.009452] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [220.074701] [045/133] (803s left) gem_mmap_gtt (big-bo) [220.125892] Subtest big-bo: SKIP (0.000s) [220.180541] [046/133] (803s left) perf_pmu (init-sema) [220.214222] Starting subtest: init-sema [220.215140] Starting dynamic subtest: rcs0 [220.218681] Dynamic subtest rcs0: SUCCESS (0.002s) [220.229171] Starting dynamic subtest: bcs0 [220.230034] Dynamic subtest bcs0: SUCCESS (0.000s) [220.236726] Starting dynamic subtest: vcs0 [220.237569] Dynamic subtest vcs0: SUCCESS (0.001s) [220.244138] Starting dynamic subtest: vcs1 [220.244934] Dynamic subtest vcs1: SUCCESS (0.001s) [220.251507] Starting dynamic subtest: vecs0 [220.252383] Dynamic subtest vecs0: SUCCESS (0.001s) [220.259121] Starting dynamic subtest: ccs0 [220.259908] Dynamic subtest ccs0: SUCCESS (0.000s) [220.260781] Subtest init-sema: SUCCESS (0.008s) [220.329691] [047/133] (803s left) prime_mmap (test_errors) [220.375464] Starting subtest: test_errors [220.376346] Starting dynamic subtest: test_errors-smem [220.475542] Dynamic subtest test_errors-smem: SUCCESS (0.101s) [220.477190] Subtest test_errors: SUCCESS (0.102s) [220.569808] [048/133] (803s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [220.649481] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc [220.650492] Starting dynamic subtest: pipe-A-eDP-1 [220.659616] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [220.667174] Starting dynamic subtest: pipe-B-eDP-1 [220.683646] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [220.690808] Starting dynamic subtest: pipe-C-eDP-1 [220.698611] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [220.705348] Starting dynamic subtest: pipe-D-eDP-1 [220.713273] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [220.714851] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [222.836697] [049/133] (800s left) gem_exercise_blt (fast-copy-emit) [222.900167] Starting subtest: fast-copy-emit [222.901082] Starting dynamic subtest: linear-smem-smem-emit [222.922179] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s) [222.931118] Starting dynamic subtest: xmajor-smem-smem-emit [222.939525] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s) [222.947967] Starting dynamic subtest: tile4-smem-smem-emit [222.956432] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s) [222.962937] Starting dynamic subtest: tile64-smem-smem-emit [222.974255] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s) [222.975075] Subtest fast-copy-emit: SUCCESS (0.074s) [223.085600] [050/133] (800s left) kms_psr (pr-cursor-render) [223.168615] Starting subtest: pr-cursor-render [223.170377] Subtest pr-cursor-render: SKIP (0.000s) [223.236646] [051/133] (800s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [223.344248] Starting subtest: psr-rgb101010-draw-blt [230.788256] Subtest psr-rgb101010-draw-blt: SUCCESS (7.444s) [230.903788] [052/133] (792s left) gem_ctx_engines (execute-oneforall) [230.960098] Starting subtest: execute-oneforall [231.666978] Subtest execute-oneforall: SUCCESS (0.698s) [233.022791] [053/133] (790s left) kms_content_protection (uevent-hdcp14) [233.173337] Starting subtest: uevent-hdcp14 [233.175079] Subtest uevent-hdcp14: SKIP (0.000s) [233.281815] [054/133] (790s left) kms_plane (plane-position-hole) [233.363283] Starting subtest: plane-position-hole [233.870141] Starting dynamic subtest: pipe-A-plane-1 [235.175297] Dynamic subtest pipe-A-plane-1: SUCCESS (1.303s) [235.183450] Starting dynamic subtest: pipe-A-plane-2 [236.490242] Dynamic subtest pipe-A-plane-2: SUCCESS (1.315s) [236.501462] Starting dynamic subtest: pipe-A-plane-3 [237.818984] Dynamic subtest pipe-A-plane-3: SUCCESS (1.327s) [237.826461] Starting dynamic subtest: pipe-A-plane-4 [239.044072] Dynamic subtest pipe-A-plane-4: SUCCESS (1.224s) [239.051482] Starting dynamic subtest: pipe-A-plane-5 [239.070335] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s) [240.221308] Starting dynamic subtest: pipe-B-plane-1 [241.548956] Dynamic subtest pipe-B-plane-1: SUCCESS (1.338s) [241.556506] Starting dynamic subtest: pipe-B-plane-2 [242.884804] Dynamic subtest pipe-B-plane-2: SUCCESS (1.335s) [242.891824] Starting dynamic subtest: pipe-B-plane-3 [244.229990] Dynamic subtest pipe-B-plane-3: SUCCESS (1.344s) [244.237084] Starting dynamic subtest: pipe-B-plane-4 [245.536609] Dynamic subtest pipe-B-plane-4: SUCCESS (1.306s) [245.543698] Starting dynamic subtest: pipe-B-plane-5 [245.561878] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s) [245.562967] Subtest plane-position-hole: SUCCESS (12.199s) [246.336386] [055/133] (777s left) syncobj_wait (invalid-signal-zero-handles) [246.392237] Starting subtest: invalid-signal-zero-handles [246.393139] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [246.493692] [056/133] (777s left) kms_lease (lease-unleased-connector) [246.576544] Starting subtest: lease-unleased-connector [246.577631] Starting dynamic subtest: pipe-A-eDP-1 [246.582691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s) [246.591660] Starting dynamic subtest: pipe-B-eDP-1 [246.592672] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s) [246.600392] Starting dynamic subtest: pipe-C-eDP-1 [246.601222] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s) [246.610219] Starting dynamic subtest: pipe-D-eDP-1 [246.611104] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s) [246.612020] Subtest lease-unleased-connector: SUCCESS (0.036s) [246.701809] [057/133] (777s left) kms_big_fb (linear-64bpp-rotate-270) [246.809094] Starting subtest: linear-64bpp-rotate-270 [246.830130] Subtest linear-64bpp-rotate-270: SKIP (0.021s) [246.937227] [058/133] (776s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [246.997352] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [247.062312] [059/133] (776s left) kms_flip (2x-blocking-absolute-wf_vblank) [247.152706] Starting subtest: 2x-blocking-absolute-wf_vblank [247.164079] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s) [247.240327] [060/133] (776s left) i915_drm_fdinfo (memory-info-shared) [247.270525] Starting subtest: memory-info-shared [247.271432] Starting dynamic subtest: smem0 [247.293250] Dynamic subtest smem0: SUCCESS (0.022s) [247.294431] Subtest memory-info-shared: SUCCESS (0.023s) [247.362663] [061/133] (776s left) gem_exec_balancer (busy) [247.432293] Starting subtest: busy [248.928960] Subtest busy: SUCCESS (1.488s) [249.247948] [062/133] (774s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [249.310590] Starting subtest: multi-wait-available-unsubmitted-signaled [249.311443] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [249.421012] [063/133] (774s left) gem_userptr_blits (stress-mm) [249.484211] Starting subtest: stress-mm [254.899578] Subtest stress-mm: SUCCESS (5.369s) [254.966851] [064/133] (769s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [255.053870] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [255.055595] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [255.145237] [065/133] (768s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [255.232065] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [262.806090] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.574s) [262.945832] [066/133] (761s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [263.041654] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [263.043383] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [263.120848] [067/133] (761s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [263.203387] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [263.204479] Starting dynamic subtest: pipe-A-default-mode [264.397131] Dynamic subtest pipe-A-default-mode: SKIP (1.192s) [264.398787] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.193s) [264.547577] [068/133] (759s left) gem_exec_balancer (parallel-contexts) [264.816673] Starting subtest: parallel-contexts [268.130505] Subtest parallel-contexts: SUCCESS (3.315s) [268.222909] [069/133] (756s left) vgem_basic (debugfs) [268.346989] Starting subtest: debugfs [268.348036] Subtest debugfs: SUCCESS (0.000s) [268.399899] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true [268.402045] [070/133] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [268.493139] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [268.494763] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [268.592261] [071/133] (755s left) kms_color (invalid-ctm-matrix-sizes) [268.673453] Starting subtest: invalid-ctm-matrix-sizes [268.674332] Starting dynamic subtest: pipe-A [268.675184] Dynamic subtest pipe-A: SUCCESS (0.002s) [268.682540] Starting dynamic subtest: pipe-B [268.683547] Dynamic subtest pipe-B: SUCCESS (0.003s) [268.692959] Starting dynamic subtest: pipe-C [268.693801] Dynamic subtest pipe-C: SUCCESS (0.004s) [268.700776] Starting dynamic subtest: pipe-D [268.701716] Dynamic subtest pipe-D: SUCCESS (0.004s) [268.702494] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s) [268.760927] [072/133] (755s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [268.873632] Starting subtest: cursorA-vs-flipB-atomic-transitions [268.877143] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.002s) [269.060142] [073/133] (755s left) gem_exec_params (invalid-batch-start-offset) [269.115394] Starting subtest: invalid-batch-start-offset [269.117749] Subtest invalid-batch-start-offset: SUCCESS (0.002s) [269.231145] [074/133] (755s left) syncobj_eventfd (invalid-illegal-eventfd) [269.289152] Starting subtest: invalid-illegal-eventfd [269.290196] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [269.376542] [075/133] (755s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [269.482425] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [269.484095] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [269.579397] [076/133] (754s left) gem_pread (self) [269.633404] Subtest self: SKIP (0.000s) [269.698889] [077/133] (754s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [269.753906] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [269.754902] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s) [269.840444] [078/133] (754s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [269.921673] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [269.923397] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [270.056057] [079/133] (754s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [270.155399] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [270.157270] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [270.222655] [080/133] (754s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [270.269340] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [270.320168] [081/133] (754s left) gem_exec_fence (submit) [270.500964] Starting subtest: submit [270.502782] Subtest submit: SKIP (0.000s) [271.979632] [082/133] (752s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [272.071639] Starting subtest: fbcpsr-rgb565-draw-pwrite [279.184511] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.113s) [279.291970] [083/133] (745s left) kms_addfb_basic (no-handle) [279.348110] Starting subtest: no-handle [279.349072] Subtest no-handle: SUCCESS (0.000s) [279.478387] [084/133] (745s left) perf (blocking) [279.564536] Starting subtest: blocking [279.565593] Starting dynamic subtest: 0-rcs0 [289.599245] Dynamic subtest 0-rcs0: SUCCESS (10.024s) [289.612163] Starting dynamic subtest: 1-vcs0 [299.657539] Dynamic subtest 1-vcs0: SUCCESS (10.019s) [299.658914] Subtest blocking: SUCCESS (20.046s) [299.693025] [085/133] (725s left) kms_prime (basic-modeset-hybrid) [299.773262] Subtest basic-modeset-hybrid: SKIP (0.000s) [299.861704] [086/133] (725s left) gem_exec_whisper (basic-contexts) [299.912273] Starting subtest: basic-contexts [306.856545] Subtest basic-contexts: SUCCESS (6.932s) [307.030927] [087/133] (717s left) kms_cursor_crc (cursor-random-64x21) [307.242347] Starting subtest: cursor-random-64x21 [307.289501] Subtest cursor-random-64x21: SKIP (0.046s) [307.557919] [088/133] (717s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [307.654845] Starting subtest: fbc-rgb101010-draw-pwrite [313.174292] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.522s) [314.303133] [089/133] (710s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [314.398432] Starting subtest: bad-pixel-format-y-tiled-ccs [314.399353] Starting dynamic subtest: pipe-A-eDP-1 [314.407597] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [314.416047] Starting dynamic subtest: pipe-B-eDP-1 [314.424470] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [314.432349] Starting dynamic subtest: pipe-C-eDP-1 [314.440446] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [314.448049] Starting dynamic subtest: pipe-D-eDP-1 [314.456133] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [314.457710] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s) [316.651823] [090/133] (708s left) prime_busy (before-wait) [316.712585] Starting subtest: before-wait [316.720345] Starting dynamic subtest: rcs0 [316.743810] Dynamic subtest rcs0: SUCCESS (0.023s) [316.753840] Starting dynamic subtest: bcs0 [316.785177] Dynamic subtest bcs0: SUCCESS (0.041s) [316.793603] Starting dynamic subtest: vcs0 [316.825828] Dynamic subtest vcs0: SUCCESS (0.040s) [316.834056] Starting dynamic subtest: vcs1 [316.866280] Dynamic subtest vcs1: SUCCESS (0.040s) [316.874474] Starting dynamic subtest: vecs0 [316.908023] Dynamic subtest vecs0: SUCCESS (0.041s) [316.916286] Starting dynamic subtest: ccs0 [316.949811] Dynamic subtest ccs0: SUCCESS (0.041s) [317.058294] Subtest before-wait: SUCCESS (0.344s) [317.146763] [091/133] (707s left) gem_ctx_persistence (legacy-engines-persistence) [317.195464] Starting subtest: legacy-engines-persistence [317.196290] Starting dynamic subtest: render [317.963636] Dynamic subtest render: SUCCESS (0.769s) [317.975333] Starting dynamic subtest: bsd1 [318.730379] Dynamic subtest bsd1: SUCCESS (0.764s) [318.742085] Starting dynamic subtest: bsd2 [319.502511] Dynamic subtest bsd2: SUCCESS (0.769s) [319.516876] Starting dynamic subtest: blt [320.255505] Dynamic subtest blt: SUCCESS (0.748s) [320.265709] Starting dynamic subtest: vebox [321.039444] Dynamic subtest vebox: SUCCESS (0.783s) [321.042634] Subtest legacy-engines-persistence: SUCCESS (3.846s) [321.132809] [092/133] (703s left) gem_userptr_blits (probe) [321.203256] Starting subtest: probe [321.284546] Subtest probe: SUCCESS (0.081s) [321.401907] [093/133] (703s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [321.515585] Starting subtest: cursorB-vs-flipA-atomic-transitions [321.518694] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s) [321.656471] [094/133] (703s left) gem_ccs (block-multicopy-inplace) [321.708904] Starting subtest: block-multicopy-inplace [321.710805] Subtest block-multicopy-inplace: SKIP (0.000s) [321.804167] [095/133] (703s left) gem_softpin (allocator-nopin-reserve) [321.852211] Starting subtest: allocator-nopin-reserve [321.952211] Subtest allocator-nopin-reserve: SUCCESS (0.100s) [322.066511] [096/133] (703s left) kms_fence_pin_leak [322.206852] [097/133] (703s left) api_intel_allocator (fork-simple-stress) [322.257335] Starting subtest: fork-simple-stress [327.701159] Subtest fork-simple-stress: SUCCESS (5.397s) [327.782521] [098/133] (697s left) perf (i915-ref-count) [327.854729] Starting subtest: i915-ref-count [327.890536] Subtest i915-ref-count: SUCCESS (0.034s) [327.947235] [099/133] (697s left) kms_flip (flip-vs-expired-vblank) [328.045203] Starting subtest: flip-vs-expired-vblank [328.047227] Starting dynamic subtest: A-eDP1 [336.767728] Dynamic subtest A-eDP1: SUCCESS (8.721s) [336.778702] Starting dynamic subtest: B-eDP1 [345.422925] Dynamic subtest B-eDP1: SUCCESS (8.625s) [345.431448] Starting dynamic subtest: C-eDP1 [354.053305] Dynamic subtest C-eDP1: SUCCESS (8.619s) [354.062591] Starting dynamic subtest: D-eDP1 [362.680070] Dynamic subtest D-eDP1: SUCCESS (8.624s) [362.680997] Subtest flip-vs-expired-vblank: SUCCESS (34.599s) [363.818641] [100/133] (661s left) gem_render_copy (yf-tiled) [363.875257] Starting subtest: yf-tiled [363.877159] Subtest yf-tiled: SKIP (0.000s) [364.055591] [101/133] (661s left) gem_ctx_param (invalid-param-get) [364.110706] Starting subtest: invalid-param-get [364.111839] Subtest invalid-param-get: SUCCESS (0.001s) [364.210142] [102/133] (661s left) kms_big_fb (4-tiled-16bpp-rotate-90) [364.304458] Starting subtest: 4-tiled-16bpp-rotate-90 [364.327609] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.022s) [364.427160] [103/133] (661s left) vgem_basic (bad-pad) [364.471833] Starting subtest: bad-pad [364.472742] Subtest bad-pad: SUCCESS (0.000s) [364.541246] [104/133] (660s left) kms_psr (fbc-psr-dpms) [364.629160] Starting subtest: fbc-psr-dpms [364.630127] Starting dynamic subtest: eDP-1 [364.631898] Dynamic subtest eDP-1: SKIP (0.000s) [364.633511] Subtest fbc-psr-dpms: SKIP (0.001s) [364.698978] [105/133] (660s left) gen9_exec_parse (bb-oversize) [364.745976] Subtest bb-oversize: SKIP (0.000s) [364.814774] [106/133] (660s left) syncobj_timeline (single-wait-all-available-signaled) [364.865556] Starting subtest: single-wait-all-available-signaled [364.866481] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [364.972456] [107/133] (660s left) gem_tiled_blits (normal) [365.022768] Subtest normal: SKIP (0.000s) [365.082452] [108/133] (660s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [365.123870] Starting subtest: invalid-multi-wait-all-unsubmitted [365.124937] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [365.244548] [109/133] (660s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [365.328363] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [365.329242] Starting dynamic subtest: pipe-A-eDP-1 [382.548113] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.965s) [382.557157] Starting dynamic subtest: pipe-B-eDP-1 [400.538253] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.892s) [400.550820] Starting dynamic subtest: pipe-C-eDP-1 [418.469531] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.784s) [418.479057] Starting dynamic subtest: pipe-D-eDP-1 [436.475881] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.750s) [436.477181] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.397s) [443.768958] [110/133] (588s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [443.870733] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [443.898404] Starting dynamic subtest: pipe-A-plane-0 [444.321276] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s) [444.330181] Starting dynamic subtest: pipe-A-plane-3 [444.577082] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s) [444.586123] Starting dynamic subtest: pipe-A-plane-5 [444.588769] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [445.715414] Starting dynamic subtest: pipe-B-plane-0 [446.147815] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s) [446.156857] Starting dynamic subtest: pipe-B-plane-3 [446.414623] Dynamic subtest pipe-B-plane-3: SUCCESS (0.265s) [446.423805] Starting dynamic subtest: pipe-B-plane-5 [446.425762] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [446.724691] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.849s) [447.589093] [111/133] (584s left) kms_chamelium_edid (hdmi-mode-timings) [447.968842] Subtest hdmi-mode-timings: SKIP (0.000s) [448.792897] [112/133] (583s left) syncobj_wait (single-wait-for-submit-signaled) [448.845675] Starting subtest: single-wait-for-submit-signaled [448.846737] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [448.952035] [113/133] (582s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [449.037893] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [449.039195] Starting dynamic subtest: pipe-A-eDP-1 [449.071384] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s) [449.081363] Starting dynamic subtest: pipe-B-eDP-1 [449.112122] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [449.120879] Starting dynamic subtest: pipe-C-eDP-1 [449.150820] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [449.159400] Starting dynamic subtest: pipe-D-eDP-1 [449.190826] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [449.193277] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.011s) [451.195037] [114/133] (580s left) kms_pm_dc (dc5-retention-flops) [452.297728] Starting subtest: dc5-retention-flops [452.299915] Subtest dc5-retention-flops: SKIP (0.000s) [452.368627] [115/133] (579s left) gem_exec_schedule (semaphore-user) [452.421940] Starting subtest: semaphore-user [452.482196] Subtest semaphore-user: SUCCESS (0.060s) [453.732646] [116/133] (578s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [453.823177] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf [453.824291] Starting dynamic subtest: pipe-A-eDP-1 [464.851550] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.023s) [464.860784] Starting dynamic subtest: pipe-B-eDP-1 [476.556697] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.702s) [476.557676] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.728s) [477.378058] [117/133] (554s left) kms_force_connector_basic (force-edid) [477.451222] Starting subtest: force-edid [477.815525] Subtest force-edid: SUCCESS (0.365s) [477.949701] [118/133] (554s left) kms_feature_discovery (display-3x) [478.026150] Starting subtest: display-3x [478.028695] Subtest display-3x: SKIP (0.000s) [478.096363] [119/133] (554s left) kms_joiner (invalid-modeset-force-ultra-joiner) [478.182324] Starting subtest: invalid-modeset-force-ultra-joiner [478.184635] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [478.250090] [120/133] (553s left) gem_mmap_offset (partial-mmap) [478.296251] Starting subtest: partial-mmap [478.297591] Starting dynamic subtest: smem0 [478.299997] Dynamic subtest smem0: SUCCESS (0.004s) [478.300966] Subtest partial-mmap: SUCCESS (0.004s) [478.407525] [121/133] (553s left) kms_flip (flip-vs-fences) [478.499801] Starting subtest: flip-vs-fences [478.502216] Subtest flip-vs-fences: SKIP (0.000s) [478.593114] [122/133] (553s left) syncobj_wait (single-wait-submitted) [478.641262] Starting subtest: single-wait-submitted [478.744196] Subtest single-wait-submitted: SUCCESS (0.103s) [478.817055] [123/133] (553s left) i915_drm_fdinfo (virtual-idle) [478.861586] Starting subtest: virtual-idle [481.929633] Subtest virtual-idle: SUCCESS (3.057s) [481.997960] [124/133] (550s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [482.051739] Starting subtest: invalid-multi-wait-unsubmitted-signaled [482.052723] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [482.147765] [125/133] (550s left) kms_psr (psr-primary-mmap-gtt) [482.233677] Starting subtest: psr-primary-mmap-gtt [482.234545] Starting dynamic subtest: eDP-1 [483.688413] Dynamic subtest eDP-1: SKIP (1.442s) [483.691245] Subtest psr-primary-mmap-gtt: SKIP (1.445s) [483.825747] [126/133] (548s left) kms_vblank (wait-busy) [483.907826] Starting subtest: wait-busy [483.909023] Starting dynamic subtest: pipe-A-eDP-1 [485.792771] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s) [485.804297] Starting dynamic subtest: pipe-D-eDP-1 [488.348810] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.554s) [488.350127] Subtest wait-busy: SUCCESS (4.442s) [489.211962] [127/133] (543s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [489.297069] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [493.320140] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.022s) [494.525671] [128/133] (537s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw) [494.622907] Starting subtest: psr-2p-pri-indfb-multidraw [494.624797] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s) [494.728214] [129/133] (537s left) i915_suspend (fence-restore-tiled2untiled) [494.779294] Starting subtest: fence-restore-tiled2untiled [494.781942] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [494.865384] [130/133] (537s left) perf (non-system-wide-paranoid) [494.959720] Starting subtest: non-system-wide-paranoid [494.983775] Subtest non-system-wide-paranoid: SUCCESS (0.026s) [495.029999] [131/133] (537s left) kms_cursor_crc (cursor-offscreen-128x128) [495.244489] Starting subtest: cursor-offscreen-128x128 [495.248093] Starting dynamic subtest: pipe-A-eDP-1 [497.180782] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s) [497.211026] Starting dynamic subtest: pipe-D-eDP-1 [499.784434] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.581s) [499.785821] Subtest cursor-offscreen-128x128: SUCCESS (4.540s) [500.599967] [132/133] (531s left) prime_self_import (basic-with_two_bos) [500.635325] Starting subtest: basic-with_two_bos [500.659172] Subtest basic-with_two_bos: SUCCESS (0.025s) [500.759725] [133/133] (531s left) gem_ringfill (legacy-basic) [506.670700] Starting subtest: legacy-basic [506.672008] Starting dynamic subtest: default [506.720221] Dynamic subtest default: SUCCESS (0.055s) [506.735695] Starting dynamic subtest: render [506.762924] Dynamic subtest render: SUCCESS (0.041s) [506.773637] Starting dynamic subtest: bsd [506.808663] Dynamic subtest bsd: SUCCESS (0.043s) [506.820532] Starting dynamic subtest: bsd1 [506.853629] Dynamic subtest bsd1: SUCCESS (0.042s) [506.865562] Starting dynamic subtest: bsd2 [506.894260] Dynamic subtest bsd2: SUCCESS (0.038s) [506.907315] Starting dynamic subtest: blt [506.941386] Dynamic subtest blt: SUCCESS (0.045s) [506.953557] Starting dynamic subtest: vebox [506.987862] Dynamic subtest vebox: SUCCESS (0.043s) [506.989649] Subtest legacy-basic: SUCCESS (0.325s) [507.080645] Closing watchdogs results: parsing output: 0/ for test: dumb_buffer results: parsing output: 1/ for test: gem_basic results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: gem_exec_async results: parsing output: 5/ for test: syncobj_wait results: parsing output: 6/ for test: i915_query results: parsing output: 7/ for test: kms_vblank results: parsing output: 8/ for test: core_auth results: parsing output: 9/ for test: kms_cursor_legacy results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: kms_async_flips results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_dither results: parsing output: 15/ for test: kms_cursor_edge_walk results: parsing output: 16/ for test: kms_chamelium_hpd results: parsing output: 17/ for test: kms_chamelium_color results: parsing output: 18/ for test: kms_pipe_crc_basic results: parsing output: 19/ for test: kms_plane_cursor results: parsing output: 20/ for test: prime_self_import results: parsing output: 21/ for test: gem_lmem_swapping results: parsing output: 22/ for test: kms_rotation_crc results: parsing output: 23/ for test: i915_pm_rps results: parsing output: 24/ for test: kms_plane_scaling results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: gem_ctx_param results: parsing output: 27/ for test: gem_exec_schedule results: parsing output: 28/ for test: gem_eio results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_big_fb results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_psr results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_async_flips results: parsing output: 36/ for test: gem_mmap_wc results: parsing output: 37/ for test: perf results: parsing output: 38/ for test: kms_prop_blob results: parsing output: 39/ for test: perf results: parsing output: 40/ for test: prime_mmap results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_psr results: parsing output: 43/ for test: kms_psr results: parsing output: 44/ for test: gem_mmap_gtt results: parsing output: 45/ for test: perf_pmu results: parsing output: 46/ for test: prime_mmap results: parsing output: 47/ for test: kms_ccs results: parsing output: 48/ for test: gem_exercise_blt results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_ctx_engines results: parsing output: 52/ for test: kms_content_protection results: parsing output: 53/ for test: kms_plane results: parsing output: 54/ for test: syncobj_wait results: parsing output: 55/ for test: kms_lease results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: gem_exec_reloc results: parsing output: 58/ for test: kms_flip results: parsing output: 59/ for test: i915_drm_fdinfo results: parsing output: 60/ for test: gem_exec_balancer results: parsing output: 61/ for test: syncobj_timeline results: parsing output: 62/ for test: gem_userptr_blits results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_flip_scaled_crc results: parsing output: 67/ for test: gem_exec_balancer results: parsing output: 68/ for test: vgem_basic results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_color results: parsing output: 71/ for test: kms_cursor_legacy results: parsing output: 72/ for test: gem_exec_params results: parsing output: 73/ for test: syncobj_eventfd results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: gem_pread results: parsing output: 76/ for test: syncobj_timeline results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_flip_scaled_crc results: parsing output: 79/ for test: kms_pipe_b_c_ivb results: parsing output: 80/ for test: gem_exec_fence results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: perf results: parsing output: 84/ for test: kms_prime results: parsing output: 85/ for test: gem_exec_whisper results: parsing output: 86/ for test: kms_cursor_crc results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: prime_busy results: parsing output: 90/ for test: gem_ctx_persistence results: parsing output: 91/ for test: gem_userptr_blits results: parsing output: 92/ for test: kms_cursor_legacy results: parsing output: 93/ for test: gem_ccs results: parsing output: 94/ for test: gem_softpin results: parsing output: 95/ for test: kms_fence_pin_leak results: parsing output: 96/ for test: api_intel_allocator results: parsing output: 97/ for test: perf results: parsing output: 98/ for test: kms_flip results: parsing output: 99/ for test: gem_render_copy results: parsing output: 100/ for test: gem_ctx_param results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: vgem_basic results: parsing output: 103/ for test: kms_psr results: parsing output: 104/ for test: gen9_exec_parse results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: gem_tiled_blits results: parsing output: 107/ for test: syncobj_timeline results: parsing output: 108/ for test: kms_ccs results: parsing output: 109/ for test: kms_plane results: parsing output: 110/ for test: kms_chamelium_edid results: parsing output: 111/ for test: syncobj_wait results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: kms_pm_dc results: parsing output: 114/ for test: gem_exec_schedule results: parsing output: 115/ for test: kms_psr2_sf results: parsing output: 116/ for test: kms_force_connector_basic results: parsing output: 117/ for test: kms_feature_discovery results: parsing output: 118/ for test: kms_joiner results: parsing output: 119/ for test: gem_mmap_offset results: parsing output: 120/ for test: kms_flip results: parsing output: 121/ for test: syncobj_wait results: parsing output: 122/ for test: i915_drm_fdinfo results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_vblank results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: i915_suspend results: parsing output: 129/ for test: perf results: parsing output: 130/ for test: kms_cursor_crc results: parsing output: 131/ for test: prime_self_import results: parsing output: 132/ for test: gem_ringfill Done.