[58.382780] Initializing watchdogs [58.382829] /dev/watchdog0 [58.397522] [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] [58.401779] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.404053] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.407609] [001/132] (960s left) gem_userptr_blits (sd-probe) [58.503600] Starting subtest: sd-probe [58.505545] Subtest sd-probe: SUCCESS (0.000s) [58.616012] [002/132] (960s left) sw_sync (sync_busy_fork_unixsocket) [58.650657] Starting subtest: sync_busy_fork_unixsocket [58.657259] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s) [58.715395] [003/132] (960s left) gem_ctx_isolation (dirty-switch) [58.771120] Starting subtest: dirty-switch [58.773420] Starting dynamic subtest: rcs0 [59.029295] Dynamic subtest rcs0: SUCCESS (0.258s) [59.039195] Starting dynamic subtest: bcs0 [59.258845] Dynamic subtest bcs0: SUCCESS (0.229s) [59.266195] Starting dynamic subtest: vcs0 [59.503686] Dynamic subtest vcs0: SUCCESS (0.245s) [59.511926] Starting dynamic subtest: vcs1 [61.088403] Dynamic subtest vcs1: SUCCESS (1.584s) [61.098237] Starting dynamic subtest: vecs0 [63.135752] Dynamic subtest vecs0: SUCCESS (2.047s) [63.145083] Starting dynamic subtest: ccs0 [65.122973] Dynamic subtest ccs0: SUCCESS (1.987s) [65.125644] Subtest dirty-switch: SUCCESS (6.352s) [65.361656] [004/132] (953s left) api_intel_allocator (gem-pool) [65.413936] Starting subtest: gem-pool [65.421937] Subtest gem-pool: SUCCESS (0.010s) [65.560202] [005/132] (953s left) kms_psr (fbc-psr-sprite-blt) [65.663856] Starting subtest: fbc-psr-sprite-blt [65.666096] Starting dynamic subtest: eDP-1 [65.670434] Dynamic subtest eDP-1: SKIP (0.000s) [65.674878] Subtest fbc-psr-sprite-blt: SKIP (0.000s) [65.732200] [006/132] (953s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear) [65.834999] Starting subtest: fbcpsr-tiling-linear [72.469116] Subtest fbcpsr-tiling-linear: SUCCESS (6.640s) [72.587140] [007/132] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [72.685793] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [72.689778] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [72.770623] [008/132] (946s left) kms_content_protection (dp-mst-type-1) [72.919959] Starting subtest: dp-mst-type-1 [72.924595] Subtest dp-mst-type-1: SKIP (0.000s) [73.037549] [009/132] (946s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [73.106223] Starting subtest: multi-wait-all-for-submit-available-signaled [73.108778] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.002s) [73.217054] [010/132] (946s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [73.314946] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [81.421034] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (8.110s) [81.551660] [011/132] (937s left) i915_pm_rpm (gem-execbuf-stress) [83.109421] Starting subtest: gem-execbuf-stress [83.112620] Starting dynamic subtest: smem0 [96.056079] Dynamic subtest smem0: SUCCESS (12.946s) [96.066790] Starting dynamic subtest: extra-wait-smem0 [157.817049] Dynamic subtest extra-wait-smem0: SUCCESS (61.757s) [157.819570] Subtest gem-execbuf-stress: SUCCESS (74.706s) [158.191535] [012/132] (861s left) gem_mmap_gtt (bad-object) [158.259970] Subtest bad-object: SKIP (0.000s) [158.314669] [013/132] (861s left) kms_addfb_basic (bad-pitch-65536) [158.374696] Starting subtest: bad-pitch-65536 [158.377035] Subtest bad-pitch-65536: SUCCESS (0.000s) [158.517118] [014/132] (860s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [158.608553] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [158.610834] Starting dynamic subtest: pipe-A-eDP-1 [158.633859] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [158.643567] Starting dynamic subtest: pipe-B-eDP-1 [158.665322] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [158.672945] Starting dynamic subtest: pipe-C-eDP-1 [158.694246] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [158.702048] Starting dynamic subtest: pipe-D-eDP-1 [158.723380] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [158.727449] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [160.772221] [015/132] (858s left) kms_big_fb (x-tiled-32bpp-rotate-90) [160.875136] Starting subtest: x-tiled-32bpp-rotate-90 [160.894985] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s) [161.006615] [016/132] (858s left) gem_mmap_gtt (flink-race) [161.060255] Subtest flink-race: SKIP (0.000s) [161.117767] [017/132] (858s left) kms_psr (psr2-primary-render) [161.213026] Starting subtest: psr2-primary-render [161.215240] Starting dynamic subtest: eDP-1 [162.966225] Dynamic subtest eDP-1: SUCCESS (1.757s) [162.968538] Subtest psr2-primary-render: SUCCESS (1.758s) [163.824634] [018/132] (855s left) gem_pxp (fail-invalid-protected-context) [163.945478] Starting subtest: fail-invalid-protected-context [163.948039] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [164.063930] [019/132] (855s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [164.160156] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [164.162406] Starting dynamic subtest: pipe-A-default-mode [166.887224] Dynamic subtest pipe-A-default-mode: SUCCESS (2.725s) [166.889475] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.726s) [167.715625] [020/132] (851s left) gem_ctx_param (invalid-param-set) [167.772072] Starting subtest: invalid-param-set [167.774313] Subtest invalid-param-set: SUCCESS (0.000s) [167.842411] [021/132] (851s left) prime_mmap (test_forked) [167.902177] Starting subtest: test_forked [167.904477] Starting dynamic subtest: test_forked-smem [167.939838] Dynamic subtest test_forked-smem: SUCCESS (0.038s) [167.942604] Subtest test_forked: SUCCESS (0.039s) [168.061449] [022/132] (851s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [168.166203] Starting subtest: invalidate-primary-flip-overlay [178.906587] Subtest invalidate-primary-flip-overlay: SUCCESS (10.742s) [179.008449] [023/132] (840s left) perf (unprivileged-single-ctx-counters) [179.135509] Starting subtest: unprivileged-single-ctx-counters [179.139126] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [179.172892] [024/132] (840s left) kms_color (legacy-gamma) [179.261458] Starting subtest: legacy-gamma [179.263470] Starting dynamic subtest: pipe-A-eDP-1 [179.971828] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [179.981028] Starting dynamic subtest: pipe-B-eDP-1 [181.463590] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.494s) [181.472771] Starting dynamic subtest: pipe-C-eDP-1 [182.855400] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.391s) [182.863888] Starting dynamic subtest: pipe-D-eDP-1 [184.251857] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.394s) [184.253873] Subtest legacy-gamma: SUCCESS (4.989s) [185.066737] [025/132] (834s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [185.164812] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [185.169123] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [185.256724] [026/132] (834s left) gem_exec_create (legacy) [185.310069] Starting subtest: legacy [185.312390] Starting dynamic subtest: smem [187.398745] Dynamic subtest smem: SUCCESS (2.088s) [187.401269] Subtest legacy: SUCCESS (2.089s) [187.586970] [027/132] (832s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [187.641222] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [187.744200] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s) [187.819883] [028/132] (832s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [187.913635] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [187.917944] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [189.002440] [029/132] (831s left) kms_sequence (queue-idle) [189.091893] Starting subtest: queue-idle [189.094330] Starting dynamic subtest: pipe-A-eDP-1 [190.917310] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.822s) [190.925928] Starting dynamic subtest: pipe-B-eDP-1 [193.388558] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.469s) [193.397765] Starting dynamic subtest: pipe-C-eDP-1 [195.893049] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.504s) [195.902031] Starting dynamic subtest: pipe-D-eDP-1 [198.308484] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.414s) [198.310674] Subtest queue-idle: SUCCESS (9.214s) [199.116949] [030/132] (820s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats) [199.502208] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s) [200.324030] [031/132] (819s left) gem_wait (invalid-buf) [200.377120] Starting subtest: invalid-buf [200.379400] Subtest invalid-buf: SUCCESS (0.000s) [200.577785] [032/132] (819s left) gem_render_copy (linear-to-vebox-yf-tiled) [200.633275] Starting subtest: linear-to-vebox-yf-tiled [200.637752] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [200.828403] [033/132] (819s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [200.924744] Starting subtest: yf-tiled-32bpp-rotate-90 [200.929311] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [201.015291] [034/132] (819s left) kms_rmfb (rmfb-ioctl) [201.108049] Starting subtest: rmfb-ioctl [201.110041] Starting dynamic subtest: pipe-A-eDP-1 [201.211846] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [201.221636] Starting dynamic subtest: pipe-B-eDP-1 [202.411316] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.198s) [202.421309] Starting dynamic subtest: pipe-C-eDP-1 [203.543358] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s) [203.550780] Starting dynamic subtest: pipe-D-eDP-1 [204.674078] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s) [204.676413] Subtest rmfb-ioctl: SUCCESS (3.569s) [205.808793] [035/132] (814s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [205.929259] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [207.030049] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.102s) [207.159536] [036/132] (813s left) gem_create (create-ext-cpu-access-big) [207.325922] Starting subtest: create-ext-cpu-access-big [207.330734] Subtest create-ext-cpu-access-big: SKIP (0.001s) [207.407733] [037/132] (812s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [207.497719] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [214.622151] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.127s) [214.749306] [038/132] (805s left) gem_ctx_persistence (hostile) [214.802859] Starting subtest: hostile [224.311070] Subtest hostile: SUCCESS (9.502s) [224.432168] [039/132] (796s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [224.532519] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [224.537050] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [224.636309] [040/132] (795s left) kms_psr (pr-cursor-render) [224.731860] Starting subtest: pr-cursor-render [224.736168] Subtest pr-cursor-render: SKIP (0.000s) [224.807004] [041/132] (795s left) core_auth (basic-auth) [224.874022] Starting subtest: basic-auth [224.876373] Subtest basic-auth: SUCCESS (0.001s) [224.978517] [042/132] (795s left) kms_chamelium_hpd (vga-hpd-fast) [225.362577] Subtest vga-hpd-fast: SKIP (0.000s) [226.151132] [043/132] (794s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [226.219474] Starting subtest: yf-tiled-ccs-to-y-tiled [226.224214] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [226.411106] [044/132] (794s left) kms_getfb (getfb-handle-closed) [226.496204] Starting subtest: getfb-handle-closed [226.498326] Subtest getfb-handle-closed: SUCCESS (0.000s) [226.591636] [045/132] (794s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [226.685076] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [226.687229] Starting dynamic subtest: pipe-A-eDP-1 [226.711436] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [226.722814] Starting dynamic subtest: pipe-B-eDP-1 [226.745799] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [226.753428] Starting dynamic subtest: pipe-C-eDP-1 [226.776246] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [226.783451] Starting dynamic subtest: pipe-D-eDP-1 [226.806676] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [226.810947] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [228.930818] [046/132] (791s left) kms_psr (fbc-pr-cursor-plane-onoff) [229.024158] Starting subtest: fbc-pr-cursor-plane-onoff [229.028455] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [229.093337] [047/132] (791s left) kms_cursor_crc (cursor-rapid-movement-32x32) [229.247398] Starting subtest: cursor-rapid-movement-32x32 [229.296865] Subtest cursor-rapid-movement-32x32: SKIP (0.044s) [229.572534] [048/132] (791s left) prime_vgem (sync) [229.707450] Starting subtest: sync [229.709698] Starting dynamic subtest: rcs0 [229.751340] Dynamic subtest rcs0: SUCCESS (0.047s) [229.759068] Starting dynamic subtest: bcs0 [229.807592] Dynamic subtest bcs0: SUCCESS (0.056s) [229.815107] Starting dynamic subtest: vcs0 [229.854954] Dynamic subtest vcs0: SUCCESS (0.047s) [229.862471] Starting dynamic subtest: vcs1 [229.898758] Dynamic subtest vcs1: SUCCESS (0.043s) [229.906178] Starting dynamic subtest: vecs0 [229.945743] Dynamic subtest vecs0: SUCCESS (0.046s) [229.953195] Starting dynamic subtest: ccs0 [229.991014] Dynamic subtest ccs0: SUCCESS (0.044s) [229.992984] Subtest sync: SUCCESS (0.287s) [230.125086] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true [230.128252] [049/132] (790s left) core_setmaster (master-drop-set-root) [230.185335] Starting subtest: master-drop-set-root [230.198932] Subtest master-drop-set-root: SUCCESS (0.014s) [230.246991] [050/132] (790s left) kms_plane_alpha_blend (constant-alpha-min) [230.333469] Starting subtest: constant-alpha-min [230.617459] Starting dynamic subtest: pipe-A-eDP-1 [231.342302] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s) [231.350278] Starting dynamic subtest: pipe-D-eDP-1 [232.816685] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.476s) [232.818953] Subtest constant-alpha-min: SUCCESS (2.485s) [233.710038] [051/132] (787s left) prime_mmap_coherency (read) [233.773629] Starting subtest: read [239.149254] Subtest read: SUCCESS (5.374s) [239.275402] [052/132] (781s left) perf_pmu (frequency) [239.315887] Starting subtest: frequency [239.320921] Starting dynamic subtest: gt0 [241.475740] Dynamic subtest gt0: SUCCESS (2.150s) [241.485449] Starting dynamic subtest: idle-gt0 [241.980325] Dynamic subtest idle-gt0: SUCCESS (0.504s) [241.991471] Starting dynamic subtest: gt1 [246.930476] Dynamic subtest gt1: SUCCESS (4.945s) [246.940762] Starting dynamic subtest: idle-gt1 [247.435223] Dynamic subtest idle-gt1: SUCCESS (0.505s) [247.437836] Subtest frequency: SUCCESS (8.120s) [247.532658] [053/132] (773s left) api_intel_bb (misplaced-blitter) [247.590990] Starting subtest: misplaced-blitter [247.599137] Subtest misplaced-blitter: SUCCESS (0.010s) [247.718401] [054/132] (773s left) gem_exec_whisper (basic-queues-priority) [247.781223] Starting subtest: basic-queues-priority [271.016513] Subtest basic-queues-priority: SUCCESS (23.234s) [271.198234] [055/132] (749s left) kms_feature_discovery (display-3x) [271.294729] Starting subtest: display-3x [271.299015] Subtest display-3x: SKIP (0.000s) [271.379388] [056/132] (749s left) kms_busy (extended-modeset-hang-newfb-with-reset) [271.480762] Starting subtest: extended-modeset-hang-newfb-with-reset [271.483026] Starting dynamic subtest: pipe-A [286.909184] Dynamic subtest pipe-A: SUCCESS (15.425s) [286.918621] Starting dynamic subtest: pipe-D [302.759961] Dynamic subtest pipe-D: SUCCESS (15.847s) [302.762728] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.277s) [303.565023] [057/132] (717s left) gem_exec_fence (syncobj-repeat) [304.020574] Starting subtest: syncobj-repeat [304.198761] Subtest syncobj-repeat: SUCCESS (0.184s) [306.024908] [058/132] (715s left) gem_exec_balancer (nohangcheck) [306.282139] Starting subtest: nohangcheck [307.205046] Subtest nohangcheck: SUCCESS (0.921s) [307.319369] [059/132] (713s left) gem_mmap_gtt (medium-copy-odd) [307.369239] Subtest medium-copy-odd: SKIP (0.000s) [307.432013] [060/132] (713s left) gen7_exec_parse (chained-batch) [307.479901] Subtest chained-batch: SKIP (0.000s) [307.557203] [061/132] (713s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [307.673757] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [314.818810] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.150s) [314.943638] [062/132] (706s left) gem_exec_params (invalid-batch-start-offset) [315.013042] Starting subtest: invalid-batch-start-offset [315.015462] Subtest invalid-batch-start-offset: SUCCESS (0.002s) [315.127492] [063/132] (706s left) gem_mmap_wc (write-read-distinct) [315.179411] Subtest write-read-distinct: SKIP (0.000s) [315.236099] [064/132] (706s left) kms_cursor_crc (cursor-tearing-position-change) [315.347731] Starting subtest: cursor-tearing-position-change [315.350037] Starting dynamic subtest: pipe-A-eDP-1 [315.918959] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s) [315.930602] Starting dynamic subtest: pipe-D-eDP-1 [317.129664] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s) [317.131972] Subtest cursor-tearing-position-change: SUCCESS (1.780s) [317.953539] [065/132] (703s left) gem_exec_reloc (basic-wc-cpu-noreloc) [318.012151] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [318.091665] [066/132] (703s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [318.147050] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [318.250076] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s) [318.328773] [067/132] (703s left) perf (non-zero-reason) [318.424766] Starting subtest: non-zero-reason [318.427234] Starting dynamic subtest: 0-rcs0 [323.838431] Dynamic subtest 0-rcs0: SUCCESS (5.411s) [323.849923] Starting dynamic subtest: 1-vecs0 [327.753099] Dynamic subtest 1-vecs0: SUCCESS (3.914s) [327.756165] Subtest non-zero-reason: SUCCESS (9.327s) [327.801988] [068/132] (693s left) gem_exec_store (dword) [327.863642] Starting subtest: dword [327.865633] Starting dynamic subtest: rcs0 [327.932666] Dynamic subtest rcs0: SUCCESS (0.068s) [327.943748] Starting dynamic subtest: bcs0 [327.974035] Dynamic subtest bcs0: SUCCESS (0.042s) [327.984040] Starting dynamic subtest: vcs0 [328.017448] Dynamic subtest vcs0: SUCCESS (0.041s) [328.031537] Starting dynamic subtest: vcs1 [328.061161] Dynamic subtest vcs1: SUCCESS (0.042s) [328.070534] Starting dynamic subtest: vecs0 [328.104069] Dynamic subtest vecs0: SUCCESS (0.041s) [328.114394] Starting dynamic subtest: ccs0 [328.149213] Dynamic subtest ccs0: SUCCESS (0.043s) [328.151751] Subtest dword: SUCCESS (0.288s) [328.345856] [069/132] (693s left) vgem_slow (nohang) [328.387829] Starting subtest: nohang [338.547749] Subtest nohang: SUCCESS (10.159s) [338.612363] [070/132] (683s left) kms_addfb_basic (framebuffer-vs-set-tiling) [338.668131] Starting subtest: framebuffer-vs-set-tiling [338.672714] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [338.807275] [071/132] (682s left) gem_softpin (allocator-nopin) [338.867746] Starting subtest: allocator-nopin [338.954503] Subtest allocator-nopin: SUCCESS (0.086s) [339.072388] [072/132] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [339.189957] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [339.194123] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [339.293030] [073/132] (682s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [339.396156] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [339.398516] Starting dynamic subtest: pipe-A-eDP-1 [339.527071] Dynamic subtest pipe-A-eDP-1: SKIP (0.135s) [339.544651] Starting dynamic subtest: pipe-B-eDP-1 [340.731639] Dynamic subtest pipe-B-eDP-1: SKIP (1.200s) [340.736288] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.339s) [341.904163] [074/132] (679s left) i915_query (engine-info-invalid) [341.971556] Starting subtest: engine-info-invalid [341.973927] Subtest engine-info-invalid: SUCCESS (0.000s) [342.070853] [075/132] (679s left) kms_flip (2x-plain-flip) [342.159603] Starting subtest: 2x-plain-flip [342.168578] Subtest 2x-plain-flip: SKIP (0.011s) [342.250219] [076/132] (679s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [342.347105] Starting subtest: psr-indfb-scaledprimary [348.085878] Subtest psr-indfb-scaledprimary: SUCCESS (5.741s) [348.199280] [077/132] (673s left) i915_drm_fdinfo (isolation) [348.244429] Starting subtest: isolation [348.246636] Starting dynamic subtest: rcs0 [348.264577] Dynamic subtest rcs0: SKIP (0.020s) [348.275663] Starting dynamic subtest: bcs0 [348.279809] Dynamic subtest bcs0: SKIP (0.000s) [348.288063] Starting dynamic subtest: vcs0 [348.291935] Dynamic subtest vcs0: SKIP (0.000s) [348.300243] Starting dynamic subtest: vcs1 [348.304237] Dynamic subtest vcs1: SKIP (0.000s) [348.312654] Starting dynamic subtest: vecs0 [348.316843] Dynamic subtest vecs0: SKIP (0.000s) [348.325263] Starting dynamic subtest: ccs0 [348.329432] Dynamic subtest ccs0: SKIP (0.000s) [348.333568] Subtest isolation: SKIP (0.025s) [348.370583] [078/132] (673s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [348.470829] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [357.866894] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.397s) [358.017785] [079/132] (664s left) kms_frontbuffer_tracking (fbc-2p-rte) [358.114078] Starting subtest: fbc-2p-rte [358.118604] Subtest fbc-2p-rte: SKIP (0.000s) [358.211101] [080/132] (663s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [358.313355] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [358.315223] Starting dynamic subtest: pipe-A-eDP-1 [358.745048] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s) [358.756674] Starting dynamic subtest: pipe-B-eDP-1 [358.776762] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [358.786157] Starting dynamic subtest: pipe-C-eDP-1 [358.805411] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s) [358.814034] Starting dynamic subtest: pipe-D-eDP-1 [358.832933] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [358.834849] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.448s) [361.064330] [081/132] (661s left) kms_cursor_crc (cursor-offscreen-128x128) [361.280749] Starting subtest: cursor-offscreen-128x128 [361.285730] Starting dynamic subtest: pipe-A-eDP-1 [363.227563] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s) [363.257501] Starting dynamic subtest: pipe-D-eDP-1 [365.901872] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.651s) [365.904339] Subtest cursor-offscreen-128x128: SUCCESS (4.618s) [366.745788] [082/132] (655s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [366.845646] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [370.863490] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.021s) [372.027354] [083/132] (650s left) syncobj_timeline (single-wait-signaled) [372.088576] Starting subtest: single-wait-signaled [372.090583] Subtest single-wait-signaled: SUCCESS (0.000s) [372.180498] [084/132] (650s left) sysfs_heartbeat_interval (nopreempt) [372.238723] Starting subtest: nopreempt [372.241079] Starting dynamic subtest: vecs0 [381.903241] Dynamic subtest vecs0: SUCCESS (9.660s) [381.914614] Starting dynamic subtest: ccs0 [385.896798] Dynamic subtest ccs0: SUCCESS (3.993s) [385.906627] Starting dynamic subtest: vcs0 [395.923902] Dynamic subtest vcs0: SUCCESS (10.023s) [395.935600] Starting dynamic subtest: bcs0 [399.870641] Dynamic subtest bcs0: SUCCESS (3.947s) [399.879841] Starting dynamic subtest: rcs0 [403.985146] Dynamic subtest rcs0: SUCCESS (4.111s) [403.995296] Starting dynamic subtest: vcs1 [412.883288] Dynamic subtest vcs1: SUCCESS (8.896s) [412.885749] Subtest nopreempt: SUCCESS (40.645s) [412.964292] [085/132] (609s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [413.100032] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [417.545549] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.450s) [418.711926] [086/132] (603s left) kms_lease (lease-unleased-connector) [418.811934] Starting subtest: lease-unleased-connector [418.814008] Starting dynamic subtest: pipe-A-eDP-1 [418.818963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s) [418.828371] Starting dynamic subtest: pipe-B-eDP-1 [418.830645] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s) [418.840309] Starting dynamic subtest: pipe-C-eDP-1 [418.842624] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s) [418.851492] Starting dynamic subtest: pipe-D-eDP-1 [418.853614] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s) [418.855698] Subtest lease-unleased-connector: SUCCESS (0.031s) [418.947537] [087/132] (603s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [419.039347] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [419.043362] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [419.121304] [088/132] (603s left) kms_big_fb (4-tiled-32bpp-rotate-180) [419.219323] Starting subtest: 4-tiled-32bpp-rotate-180 [420.587012] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.368s) [420.718414] [089/132] (601s left) gem_exec_params (invalid-fence-in) [420.773747] Starting subtest: invalid-fence-in [420.775835] Subtest invalid-fence-in: SUCCESS (0.000s) [420.886093] [090/132] (601s left) kms_flip (basic-flip-vs-modeset) [420.969651] Starting subtest: basic-flip-vs-modeset [420.971661] Starting dynamic subtest: A-eDP1 [423.486892] Dynamic subtest A-eDP1: SUCCESS (2.515s) [423.497547] Starting dynamic subtest: B-eDP1 [425.669578] Dynamic subtest B-eDP1: SUCCESS (2.180s) [425.678840] Starting dynamic subtest: C-eDP1 [427.761341] Dynamic subtest C-eDP1: SUCCESS (2.093s) [427.774849] Starting dynamic subtest: D-eDP1 [429.921564] Dynamic subtest D-eDP1: SUCCESS (2.160s) [429.923923] Subtest basic-flip-vs-modeset: SUCCESS (8.956s) [430.725232] [091/132] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [430.824202] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [430.828139] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [430.920057] [092/132] (591s left) gem_userptr_blits (readonly-unsync) [430.988313] Subtest readonly-unsync: SKIP (0.000s) [431.112140] [093/132] (591s left) kms_pm_backlight (basic-brightness) [431.208995] Starting subtest: basic-brightness [431.256461] Starting dynamic subtest: eDP-1 [431.760424] Dynamic subtest eDP-1: SUCCESS (0.502s) [431.762612] Subtest basic-brightness: SUCCESS (0.552s) [432.556795] [094/132] (590s left) gem_eio (wait-wedge-1us) [432.783094] Starting subtest: wait-wedge-1us [433.947420] Subtest wait-wedge-1us: SUCCESS (1.165s) [434.088097] [095/132] (588s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render) [434.171439] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render [434.175488] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [434.270802] [096/132] (588s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [434.322783] Subtest writes-after-reads-snoop: SKIP (0.000s) [434.404348] [097/132] (588s left) kms_plane (plane-position-hole) [434.494099] Starting subtest: plane-position-hole [435.028804] Starting dynamic subtest: pipe-A-plane-1 [436.357698] Dynamic subtest pipe-A-plane-1: SUCCESS (1.328s) [436.367190] Starting dynamic subtest: pipe-A-plane-2 [437.713432] Dynamic subtest pipe-A-plane-2: SUCCESS (1.355s) [437.722758] Starting dynamic subtest: pipe-A-plane-3 [439.005529] Dynamic subtest pipe-A-plane-3: SUCCESS (1.292s) [439.015107] Starting dynamic subtest: pipe-A-plane-4 [440.263245] Dynamic subtest pipe-A-plane-4: SUCCESS (1.258s) [440.272774] Starting dynamic subtest: pipe-A-plane-5 [440.288108] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s) [441.516603] Starting dynamic subtest: pipe-B-plane-1 [442.858809] Dynamic subtest pipe-B-plane-1: SUCCESS (1.348s) [442.869270] Starting dynamic subtest: pipe-B-plane-2 [444.155267] Dynamic subtest pipe-B-plane-2: SUCCESS (1.300s) [444.166098] Starting dynamic subtest: pipe-B-plane-3 [445.492733] Dynamic subtest pipe-B-plane-3: SUCCESS (1.336s) [445.505668] Starting dynamic subtest: pipe-B-plane-4 [446.823686] Dynamic subtest pipe-B-plane-4: SUCCESS (1.331s) [446.833381] Starting dynamic subtest: pipe-B-plane-5 [446.851523] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s) [446.853507] Subtest plane-position-hole: SUCCESS (12.357s) [447.699192] [098/132] (575s left) kms_async_flips (test-time-stamp) [447.792265] Starting subtest: test-time-stamp [448.172295] Starting dynamic subtest: pipe-A-eDP-1 [448.994802] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.820s) [449.373752] Starting dynamic subtest: pipe-B-eDP-1 [450.114995] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.747s) [450.491964] Starting dynamic subtest: pipe-C-eDP-1 [451.248487] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s) [451.611979] Starting dynamic subtest: pipe-D-eDP-1 [452.373175] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s) [452.375599] Subtest test-time-stamp: SUCCESS (4.581s) [453.530429] [099/132] (569s left) gem_exec_reloc (basic-write-cpu-noreloc) [453.601786] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [453.673956] [100/132] (569s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [453.778532] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [453.782966] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [453.880099] [101/132] (569s left) kms_vblank (ts-continuation-modeset-hang) [453.987303] Starting subtest: ts-continuation-modeset-hang [453.989438] Starting dynamic subtest: pipe-A-eDP-1 [480.661833] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.674s) [480.675669] Starting dynamic subtest: pipe-D-eDP-1 [495.703939] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.037s) [495.705902] Subtest ts-continuation-modeset-hang: SUCCESS (41.716s) [496.547906] [102/132] (526s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [496.641309] Starting subtest: primary-yf-tiled-reflect-x-0 [496.700684] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s) [496.805836] [103/132] (526s left) kms_joiner (invalid-modeset-force-ultra-joiner) [496.903693] Starting subtest: invalid-modeset-force-ultra-joiner [496.907670] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [496.975795] [104/132] (526s left) gem_busy (semaphore) [497.154188] Subtest semaphore: SKIP (0.000s) [497.387456] [105/132] (525s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75) [497.473159] Starting subtest: planes-unity-scaling-downscale-factor-0-75 [497.475412] Starting dynamic subtest: pipe-A [497.534511] Dynamic subtest pipe-A: SUCCESS (0.064s) [497.545374] Starting dynamic subtest: pipe-B [498.663757] Dynamic subtest pipe-B: SUCCESS (1.128s) [498.675295] Starting dynamic subtest: pipe-C [499.787261] Dynamic subtest pipe-C: SUCCESS (1.122s) [499.796371] Starting dynamic subtest: pipe-D [500.921045] Dynamic subtest pipe-D: SUCCESS (1.133s) [500.923445] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.452s) [502.081121] [106/132] (521s left) syncobj_timeline (multi-wait-for-submit-available-signaled) [502.135418] Starting subtest: multi-wait-for-submit-available-signaled [502.137593] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s) [502.242780] [107/132] (521s left) kms_flip (2x-plain-flip-ts-check-interruptible) [502.332462] Starting subtest: 2x-plain-flip-ts-check-interruptible [502.343966] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s) [502.432782] [108/132] (520s left) kms_psr (fbc-psr2-primary-mmap-gtt) [502.539961] Starting subtest: fbc-psr2-primary-mmap-gtt [502.542109] Starting dynamic subtest: eDP-1 [502.546063] Dynamic subtest eDP-1: SKIP (0.000s) [502.549972] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [502.614644] [109/132] (520s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [502.699112] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [502.725051] Starting dynamic subtest: pipe-A-plane-0 [503.402988] Dynamic subtest pipe-A-plane-0: SUCCESS (0.678s) [503.421274] Starting dynamic subtest: pipe-A-plane-3 [503.813340] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s) [504.958555] Starting dynamic subtest: pipe-B-plane-0 [505.662470] Dynamic subtest pipe-B-plane-0: SUCCESS (0.711s) [505.671382] Starting dynamic subtest: pipe-B-plane-3 [506.073318] Dynamic subtest pipe-B-plane-3: SUCCESS (0.409s) [506.385695] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.688s) [507.226783] [110/132] (516s left) gem_mmap_wc (read-write-distinct) [507.287413] Subtest read-write-distinct: SKIP (0.000s) [507.359164] [111/132] (516s left) gem_exec_schedule (preempt-queue-contexts) [507.426961] Subtest preempt-queue-contexts: SKIP (0.000s) [507.724683] [112/132] (515s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [507.821467] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [507.825815] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [507.890704] [113/132] (515s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [507.980345] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [507.984705] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [508.082433] [114/132] (515s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [508.209701] Starting subtest: short-busy-flip-before-cursor-toggle [508.214193] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [508.354215] [115/132] (515s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [508.445350] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [508.447646] Starting dynamic subtest: pipe-A-eDP-1 [508.470653] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [508.483288] Starting dynamic subtest: pipe-B-eDP-1 [508.505595] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [508.514519] Starting dynamic subtest: pipe-C-eDP-1 [508.536128] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [508.544796] Starting dynamic subtest: pipe-D-eDP-1 [508.567245] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [508.571276] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s) [510.698759] [116/132] (512s left) i915_hangman (gt-engine-error) [510.771576] Starting subtest: gt-engine-error [510.773680] Starting dynamic subtest: rcs0 [511.859873] Dynamic subtest rcs0: SUCCESS (1.088s) [511.874939] Starting dynamic subtest: bcs0 [513.843755] Dynamic subtest bcs0: SUCCESS (1.981s) [513.856195] Starting dynamic subtest: vcs0 [515.827051] Dynamic subtest vcs0: SUCCESS (1.980s) [515.839882] Starting dynamic subtest: vcs1 [516.851371] Dynamic subtest vcs1: SUCCESS (1.023s) [516.863757] Starting dynamic subtest: vecs0 [518.900051] Dynamic subtest vecs0: SUCCESS (2.045s) [518.911097] Starting dynamic subtest: ccs0 [520.820328] Dynamic subtest ccs0: SUCCESS (1.917s) [520.823036] Subtest gt-engine-error: SUCCESS (10.051s) [520.905742] [117/132] (502s left) kms_addfb_basic (clobberred-modifier) [520.964715] Starting subtest: clobberred-modifier [520.969865] Subtest clobberred-modifier: SKIP (0.000s) [521.124062] [118/132] (502s left) kms_flip (flip-vs-dpms-on-nop) [521.215437] Starting subtest: flip-vs-dpms-on-nop [521.217368] Starting dynamic subtest: A-eDP1 [523.072711] Dynamic subtest A-eDP1: SUCCESS (1.859s) [523.084303] Starting dynamic subtest: B-eDP1 [524.917069] Dynamic subtest B-eDP1: SUCCESS (1.841s) [524.928738] Starting dynamic subtest: C-eDP1 [526.740164] Dynamic subtest C-eDP1: SUCCESS (1.821s) [526.755740] Starting dynamic subtest: D-eDP1 [528.655492] Dynamic subtest D-eDP1: SUCCESS (1.913s) [528.660923] Subtest flip-vs-dpms-on-nop: SUCCESS (7.449s) [529.843302] [119/132] (493s left) kms_prime (d3hot) [529.941332] Subtest D3hot: SKIP (0.000s) [530.048309] [120/132] (493s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [530.172262] Starting subtest: 2x-long-flip-vs-cursor-atomic [530.176612] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s) [530.333921] [121/132] (493s left) perf_pmu (idle) [530.381237] Starting subtest: idle [530.383486] Starting dynamic subtest: rcs0 [530.918069] Dynamic subtest rcs0: SUCCESS (0.533s) [530.929466] Starting dynamic subtest: bcs0 [531.434914] Dynamic subtest bcs0: SUCCESS (0.518s) [531.446924] Starting dynamic subtest: vcs0 [531.956926] Dynamic subtest vcs0: SUCCESS (0.519s) [531.966993] Starting dynamic subtest: vcs1 [532.483651] Dynamic subtest vcs1: SUCCESS (0.523s) [532.495568] Starting dynamic subtest: vecs0 [533.010703] Dynamic subtest vecs0: SUCCESS (0.525s) [533.022314] Starting dynamic subtest: ccs0 [533.531235] Dynamic subtest ccs0: SUCCESS (0.517s) [533.534419] Subtest idle: SUCCESS (3.152s) [533.644054] [122/132] (490s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [533.775189] Starting subtest: cursorA-vs-flipB-atomic-transitions [533.779772] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [533.934372] [123/132] (490s left) gem_exec_reloc (basic-wc) [533.987063] Subtest basic-wc: SKIP (0.000s) [534.065879] [124/132] (489s left) syncobj_timeline (etime-single-wait-submitted) [534.115493] Starting subtest: etime-single-wait-submitted [534.219045] Subtest etime-single-wait-submitted: SUCCESS (0.103s) [534.295054] [125/132] (489s left) kms_frontbuffer_tracking (basic) [534.393563] Starting subtest: basic [537.757752] Subtest basic: SUCCESS (3.368s) [537.866188] [126/132] (486s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [537.969510] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [537.973093] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [538.042774] [127/132] (486s left) perf_pmu (interrupts) [538.086969] Starting subtest: interrupts [539.169769] Subtest interrupts: SUCCESS (1.083s) [539.309837] [128/132] (484s left) gem_exec_schedule (semaphore-codependency) [539.386608] Starting subtest: semaphore-codependency [539.396272] Subtest semaphore-codependency: SUCCESS (0.015s) [539.742309] [129/132] (484s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic) [539.850085] Starting subtest: async-flip-with-page-flip-events-linear-atomic [540.223406] Starting dynamic subtest: pipe-A-eDP-1 [543.015022] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.790s) [543.389643] Starting dynamic subtest: pipe-B-eDP-1 [546.145903] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s) [546.508896] Starting dynamic subtest: pipe-C-eDP-1 [549.280400] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.778s) [549.651069] Starting dynamic subtest: pipe-D-eDP-1 [552.413387] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s) [552.415950] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.564s) [553.613425] [130/132] (470s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [553.709373] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [553.713261] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [553.802656] [131/132] (470s left) kms_big_fb (linear-32bpp-rotate-0) [553.904559] Starting subtest: linear-32bpp-rotate-0 [555.537803] Subtest linear-32bpp-rotate-0: SUCCESS (1.635s) [555.682834] [132/132] (468s left) gem_mmap_gtt (big-copy-xy) [555.744595] Subtest big-copy-XY: SKIP (0.000s) [555.807798] Closing watchdogs results: parsing output: 0/ for test: gem_userptr_blits results: parsing output: 1/ for test: sw_sync results: parsing output: 2/ for test: gem_ctx_isolation results: parsing output: 3/ for test: api_intel_allocator results: parsing output: 4/ for test: kms_psr results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_content_protection results: parsing output: 8/ for test: syncobj_timeline results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: i915_pm_rpm results: parsing output: 11/ for test: gem_mmap_gtt results: parsing output: 12/ for test: kms_addfb_basic results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: kms_big_fb results: parsing output: 15/ for test: gem_mmap_gtt results: parsing output: 16/ for test: kms_psr results: parsing output: 17/ for test: gem_pxp results: parsing output: 18/ for test: kms_flip_scaled_crc results: parsing output: 19/ for test: gem_ctx_param results: parsing output: 20/ for test: prime_mmap results: parsing output: 21/ for test: kms_psr_stress_test results: parsing output: 22/ for test: perf results: parsing output: 23/ for test: kms_color results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: gem_exec_create results: parsing output: 26/ for test: syncobj_timeline results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_sequence results: parsing output: 29/ for test: kms_chamelium_frames results: parsing output: 30/ for test: gem_wait results: parsing output: 31/ for test: gem_render_copy results: parsing output: 32/ for test: kms_big_fb results: parsing output: 33/ for test: kms_rmfb results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: gem_create results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_ctx_persistence results: parsing output: 38/ for test: kms_big_fb results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: core_auth results: parsing output: 41/ for test: kms_chamelium_hpd results: parsing output: 42/ for test: gem_render_copy results: parsing output: 43/ for test: kms_getfb results: parsing output: 44/ for test: kms_ccs results: parsing output: 45/ for test: kms_psr results: parsing output: 46/ for test: kms_cursor_crc results: parsing output: 47/ for test: prime_vgem results: parsing output: 48/ for test: core_setmaster results: parsing output: 49/ for test: kms_plane_alpha_blend results: parsing output: 50/ for test: prime_mmap_coherency results: parsing output: 51/ for test: perf_pmu results: parsing output: 52/ for test: api_intel_bb results: parsing output: 53/ for test: gem_exec_whisper results: parsing output: 54/ for test: kms_feature_discovery results: parsing output: 55/ for test: kms_busy results: parsing output: 56/ for test: gem_exec_fence results: parsing output: 57/ for test: gem_exec_balancer results: parsing output: 58/ for test: gem_mmap_gtt results: parsing output: 59/ for test: gen7_exec_parse results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: gem_exec_params results: parsing output: 62/ for test: gem_mmap_wc results: parsing output: 63/ for test: kms_cursor_crc results: parsing output: 64/ for test: gem_exec_reloc results: parsing output: 65/ for test: syncobj_wait results: parsing output: 66/ for test: perf results: parsing output: 67/ for test: gem_exec_store results: parsing output: 68/ for test: vgem_slow results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: gem_softpin results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_psr2_sf results: parsing output: 73/ for test: i915_query results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: i915_drm_fdinfo results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_ccs results: parsing output: 80/ for test: kms_cursor_crc results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: sysfs_heartbeat_interval results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_lease results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: gem_exec_params results: parsing output: 89/ for test: kms_flip results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_userptr_blits results: parsing output: 92/ for test: kms_pm_backlight results: parsing output: 93/ for test: gem_eio results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: gem_partial_pwrite_pread results: parsing output: 96/ for test: kms_plane results: parsing output: 97/ for test: kms_async_flips results: parsing output: 98/ for test: gem_exec_reloc results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_vblank results: parsing output: 101/ for test: kms_rotation_crc results: parsing output: 102/ for test: kms_joiner results: parsing output: 103/ for test: gem_busy results: parsing output: 104/ for test: kms_plane_scaling results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: kms_plane results: parsing output: 109/ for test: gem_mmap_wc results: parsing output: 110/ for test: gem_exec_schedule results: parsing output: 111/ for test: kms_psr2_sf results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_cursor_legacy results: parsing output: 114/ for test: kms_ccs results: parsing output: 115/ for test: i915_hangman results: parsing output: 116/ for test: kms_addfb_basic results: parsing output: 117/ for test: kms_flip results: parsing output: 118/ for test: kms_prime results: parsing output: 119/ for test: kms_cursor_legacy results: parsing output: 120/ for test: perf_pmu results: parsing output: 121/ for test: kms_cursor_legacy results: parsing output: 122/ for test: gem_exec_reloc results: parsing output: 123/ for test: syncobj_timeline results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_plane results: parsing output: 126/ for test: perf_pmu results: parsing output: 127/ for test: gem_exec_schedule results: parsing output: 128/ for test: kms_async_flips results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_big_fb results: parsing output: 131/ for test: gem_mmap_gtt Done.