[59.557903] Initializing watchdogs [59.557948] /dev/watchdog0 [59.572217] [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] [59.576741] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.579143] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.582399] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop) [59.678960] Subtest write-snoop: SKIP (0.000s) [59.757272] [002/133] (960s left) kms_content_protection (content-type-change) [59.908855] Starting subtest: content-type-change [59.913575] Subtest content-type-change: SKIP (0.000s) [60.084445] [003/133] (960s left) kms_rotation_crc (multiplane-rotation) [60.188076] Starting subtest: multiplane-rotation [77.765798] Subtest multiplane-rotation: SUCCESS (17.548s) [77.925085] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue) [78.029411] Subtest ctm-red-to-blue: SKIP (0.000s) [78.072809] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle) [78.139253] Starting subtest: invalid-reset-one-illegal-handle [78.141093] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [78.261113] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc) [78.372534] Starting subtest: disable-crc-after-crtc [78.374414] Starting dynamic subtest: pipe-A-eDP-1 [80.009069] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.633s) [80.018608] Starting dynamic subtest: pipe-B-eDP-1 [82.302210] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.291s) [82.311361] Starting dynamic subtest: pipe-C-eDP-1 [84.547706] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.244s) [84.556081] Starting dynamic subtest: pipe-D-eDP-1 [86.799943] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.249s) [86.802259] Subtest disable-crc-after-crtc: SUCCESS (8.422s) [87.653433] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled) [87.721431] Subtest tiled-to-tiled: SKIP (0.000s) [87.798894] [008/133] (932s left) syncobj_wait (wait-all-interrupted) [87.850420] Starting subtest: wait-all-interrupted [87.952494] Subtest wait-all-interrupted: SUCCESS (0.103s) [88.048764] [009/133] (932s left) syncobj_wait (wait-all-complex) [88.107836] Starting subtest: wait-all-complex [88.320990] Subtest wait-all-complex: SUCCESS (0.212s) [88.414026] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on) [88.540774] Starting subtest: reject-modify-context-protection-on [88.543126] Subtest reject-modify-context-protection-on: SUCCESS (0.002s) [88.678392] [011/133] (931s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [88.810343] Starting subtest: cursorA-vs-flipB-varying-size [88.814930] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [88.977117] [012/133] (931s left) kms_rotation_crc (primary-rotation-90) [89.079115] Starting subtest: primary-rotation-90 [89.083723] Subtest primary-rotation-90: SKIP (0.001s) [89.171459] [013/133] (931s left) syncobj_wait (reset-multiple-signaled) [89.234467] Starting subtest: reset-multiple-signaled [89.236767] Subtest reset-multiple-signaled: SUCCESS (0.000s) [89.343719] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs) [89.436495] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs [89.440430] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s) [90.581102] [015/133] (930s left) gem_softpin (noreloc-s3) [90.653062] Starting subtest: noreloc-S3 [111.249483] Subtest noreloc-S3: SUCCESS (5.424s) [111.423191] [016/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [111.561333] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [116.161407] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.538s) [117.296136] [017/133] (903s left) gem_ctx_param (invalid-ctx-set) [117.351198] Starting subtest: invalid-ctx-set [117.353623] Subtest invalid-ctx-set: SUCCESS (0.001s) [117.487532] [018/133] (903s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [117.556110] Starting subtest: single-wait-all-for-submit-unsubmitted [117.664632] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s) [117.763041] [019/133] (902s left) kms_big_fb (x-tiled-64bpp-rotate-90) [117.866028] Starting subtest: x-tiled-64bpp-rotate-90 [117.889125] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s) [118.037190] [020/133] (902s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [118.097175] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [118.165197] [021/133] (902s left) kms_psr (fbc-psr-cursor-plane-move) [118.257163] Starting subtest: fbc-psr-cursor-plane-move [118.259464] Starting dynamic subtest: eDP-1 [118.263972] Dynamic subtest eDP-1: SKIP (0.000s) [118.268383] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [118.371519] [022/133] (902s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [118.477256] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [119.521131] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.036s) [119.692929] [023/133] (901s left) kms_flip (2x-flip-vs-rmfb) [119.810055] Starting subtest: 2x-flip-vs-rmfb [119.819938] Subtest 2x-flip-vs-rmfb: SKIP (0.011s) [119.960160] [024/133] (901s left) kms_plane_cursor (viewport) [120.070178] Starting subtest: viewport [120.073679] Starting dynamic subtest: pipe-A-eDP-1-size-64 [122.613974] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.530s) [122.673615] Starting dynamic subtest: pipe-A-eDP-1-size-128 [125.237771] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s) [125.296659] Starting dynamic subtest: pipe-A-eDP-1-size-256 [127.857750] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.559s) [128.205068] Starting dynamic subtest: pipe-B-eDP-1-size-64 [131.509686] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.306s) [131.568943] Starting dynamic subtest: pipe-B-eDP-1-size-128 [134.158739] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.593s) [134.218353] Starting dynamic subtest: pipe-B-eDP-1-size-256 [136.753567] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.537s) [137.100865] Starting dynamic subtest: pipe-C-eDP-1-size-64 [139.980860] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.890s) [140.020017] Starting dynamic subtest: pipe-C-eDP-1-size-128 [142.204009] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.191s) [142.246560] Starting dynamic subtest: pipe-C-eDP-1-size-256 [144.393058] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.157s) [144.739496] Starting dynamic subtest: pipe-D-eDP-1-size-64 [147.579100] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.851s) [147.617421] Starting dynamic subtest: pipe-D-eDP-1-size-128 [149.823889] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.212s) [149.860685] Starting dynamic subtest: pipe-D-eDP-1-size-256 [152.136052] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.280s) [152.459932] Subtest viewport: SUCCESS (32.338s) [153.282397] [025/133] (867s left) kms_cdclk (mode-transition) [153.382890] Starting subtest: mode-transition [153.385092] Starting dynamic subtest: pipe-A-eDP-1 [153.685491] Dynamic subtest pipe-A-eDP-1: SKIP (0.299s) [153.694050] Starting dynamic subtest: pipe-B-eDP-1 [153.698428] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [153.706439] Starting dynamic subtest: pipe-C-eDP-1 [153.711358] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s) [153.719550] Starting dynamic subtest: pipe-D-eDP-1 [153.724070] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [153.728454] Subtest mode-transition: SKIP (0.309s) [154.514960] [026/133] (866s left) gem_exec_balancer (fairslice) [154.575760] Starting subtest: fairslice [157.467783] Subtest fairslice: SUCCESS (2.889s) [158.149529] [027/133] (862s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [158.271420] Starting subtest: basic-flip-before-cursor-varying-size [159.186988] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.914s) [160.044427] [028/133] (861s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [160.143750] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [160.146091] Starting dynamic subtest: pipe-A-default-mode [160.432834] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [160.437595] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.288s) [161.275907] [029/133] (859s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [161.368748] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [161.371063] Starting dynamic subtest: pipe-A-default-mode [164.117018] Dynamic subtest pipe-A-default-mode: SUCCESS (2.748s) [164.119370] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.749s) [164.969647] [030/133] (856s left) core_getstats (basic) [165.032349] Starting subtest: basic [165.034613] Subtest basic: SUCCESS (0.000s) [165.172614] [031/133] (856s left) kms_rmfb (close-fd) [165.265966] Starting subtest: close-fd [165.267859] Starting dynamic subtest: pipe-A-eDP-1 [165.375006] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s) [165.385268] Starting dynamic subtest: pipe-B-eDP-1 [166.514110] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.139s) [166.523296] Starting dynamic subtest: pipe-C-eDP-1 [167.640628] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s) [167.649481] Starting dynamic subtest: pipe-D-eDP-1 [168.767858] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s) [168.769756] Subtest close-fd: SUCCESS (3.501s) [169.996266] [032/133] (851s left) gem_exec_reloc (basic-gtt-wc) [170.058219] Subtest basic-gtt-wc: SKIP (0.000s) [170.139468] [033/133] (851s left) kms_properties (crtc-properties-legacy) [170.233653] Starting subtest: crtc-properties-legacy [170.235570] Starting dynamic subtest: pipe-A-eDP-1 [170.670936] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s) [170.679859] Starting dynamic subtest: pipe-B-eDP-1 [171.822517] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.149s) [171.832476] Starting dynamic subtest: pipe-C-eDP-1 [172.945745] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s) [172.954057] Starting dynamic subtest: pipe-D-eDP-1 [174.083352] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s) [174.085610] Subtest crtc-properties-legacy: SUCCESS (3.850s) [174.906117] [034/133] (846s left) kms_invalid_mode (zero-hdisplay) [175.007076] Starting subtest: zero-hdisplay [175.009450] Starting dynamic subtest: pipe-A-eDP-1 [175.289133] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [175.298439] Starting dynamic subtest: pipe-B-eDP-1 [175.300730] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [175.308848] Starting dynamic subtest: pipe-C-eDP-1 [175.311042] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [175.319242] Starting dynamic subtest: pipe-D-eDP-1 [175.321166] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [175.323098] Subtest zero-hdisplay: SUCCESS (0.291s) [176.139732] [035/133] (845s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [176.249054] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [176.251390] Starting dynamic subtest: pipe-A [177.297239] Dynamic subtest pipe-A: SUCCESS (1.050s) [177.306224] Starting dynamic subtest: pipe-B [179.420494] Dynamic subtest pipe-B: SUCCESS (2.121s) [179.433712] Starting dynamic subtest: pipe-C [180.611711] Dynamic subtest pipe-C: SUCCESS (1.190s) [180.620082] Starting dynamic subtest: pipe-D [181.754507] Dynamic subtest pipe-D: SUCCESS (1.142s) [181.756655] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.506s) [182.971878] [036/133] (838s left) kms_pm_rpm (legacy-planes-dpms) [185.198741] Starting subtest: legacy-planes-dpms [185.201739] Starting dynamic subtest: plane-63 [193.823953] Dynamic subtest plane-63: SUCCESS (8.620s) [193.836134] Starting dynamic subtest: plane-93 [202.453615] Dynamic subtest plane-93: SUCCESS (8.624s) [202.464632] Starting dynamic subtest: plane-123 [210.772216] Dynamic subtest plane-123: SUCCESS (8.319s) [210.783250] Starting dynamic subtest: plane-133 [219.103753] Dynamic subtest plane-133: SUCCESS (8.330s) [219.106493] Subtest legacy-planes-dpms: SUCCESS (33.905s) [219.507912] [037/133] (802s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [219.610837] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [219.615060] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [219.745812] [038/133] (801s left) kms_dirtyfb (default-dirtyfb-ioctl) [219.847990] Starting subtest: default-dirtyfb-ioctl [219.850295] Starting dynamic subtest: A-eDP-1 [221.433142] Dynamic subtest A-eDP-1: SUCCESS (1.583s) [221.435067] Subtest default-dirtyfb-ioctl: SUCCESS (1.585s) [222.336774] [039/133] (799s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [222.465305] Starting subtest: cursorB-vs-flipA-legacy [222.469822] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s) [222.632175] [040/133] (799s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [222.687986] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [222.690177] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s) [222.821670] [041/133] (798s left) kms_prime (basic-crc-vgem) [222.960684] Starting subtest: basic-crc-vgem [222.963080] Starting dynamic subtest: second-to-first [223.884651] Dynamic subtest second-to-first: SUCCESS (0.926s) [223.886613] Subtest basic-crc-vgem: SUCCESS (0.927s) [223.997849] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true [224.000682] [042/133] (797s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [224.103323] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [224.167097] [043/133] (797s left) i915_drm_fdinfo (busy) [224.207063] Starting subtest: busy [224.208726] Starting dynamic subtest: rcs0 [224.250141] Dynamic subtest rcs0: SKIP (0.042s) [224.260941] Starting dynamic subtest: bcs0 [224.264627] Dynamic subtest bcs0: SKIP (0.001s) [224.273066] Starting dynamic subtest: vcs0 [224.276588] Dynamic subtest vcs0: SKIP (0.000s) [224.284614] Starting dynamic subtest: vcs1 [224.288059] Dynamic subtest vcs1: SKIP (0.000s) [224.295833] Starting dynamic subtest: vecs0 [224.299230] Dynamic subtest vecs0: SKIP (0.000s) [224.306996] Starting dynamic subtest: ccs0 [224.310353] Dynamic subtest ccs0: SKIP (0.000s) [224.313826] Subtest busy: SKIP (0.050s) [224.350367] [044/133] (797s left) gem_userptr_blits (nohangcheck) [224.429472] Starting subtest: nohangcheck [224.696272] Subtest nohangcheck: SUCCESS (0.265s) [224.857210] [045/133] (796s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [224.966152] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [225.567924] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.603s) [225.752285] [046/133] (796s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [225.846860] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [225.851437] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [226.950006] [047/133] (794s left) kms_scaling_modes (scaling-mode-full) [227.050005] Starting subtest: scaling-mode-full [227.052294] Starting dynamic subtest: pipe-A-eDP-1 [227.141509] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s) [227.151222] Starting dynamic subtest: pipe-B-eDP-1 [228.345492] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.202s) [228.356999] Starting dynamic subtest: pipe-C-eDP-1 [229.464077] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s) [229.477233] Starting dynamic subtest: pipe-D-eDP-1 [230.592261] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s) [230.594489] Subtest scaling-mode-full: SUCCESS (3.545s) [231.789683] [048/133] (790s left) kms_psr (fbc-pr-basic) [231.891771] Starting subtest: fbc-pr-basic [231.895851] Subtest fbc-pr-basic: SKIP (0.000s) [231.989249] [049/133] (790s left) gem_ringfill (basic-all) [238.014265] Starting subtest: basic-all [239.172063] Subtest basic-all: SUCCESS (1.157s) [239.333501] [050/133] (782s left) gem_exec_whisper (basic-fds-forked-all) [239.406133] Starting subtest: basic-fds-forked-all [260.957883] Subtest basic-fds-forked-all: SUCCESS (21.550s) [261.164925] [051/133] (760s left) api_intel_bb (full-batch) [261.229107] Starting subtest: full-batch [261.236917] Subtest full-batch: SUCCESS (0.010s) [261.392641] [052/133] (760s left) kms_cursor_crc (cursor-sliding-256x85) [261.626649] Starting subtest: cursor-sliding-256x85 [261.676684] Subtest cursor-sliding-256x85: SKIP (0.045s) [261.892523] [053/133] (760s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [261.988402] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [261.990827] Starting dynamic subtest: pipe-A-eDP-1 [262.050214] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [262.060978] Starting dynamic subtest: pipe-B-eDP-1 [262.115238] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [262.125892] Starting dynamic subtest: pipe-C-eDP-1 [262.175471] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [262.185670] Starting dynamic subtest: pipe-D-eDP-1 [262.232907] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [262.236626] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s) [264.256912] [054/133] (757s left) gen9_exec_parse (allowed-single) [264.328253] Subtest allowed-single: SKIP (0.000s) [264.425267] [055/133] (757s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [264.519612] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [271.640862] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.122s) [271.791822] [056/133] (750s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [271.892461] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [271.896962] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [272.027406] [057/133] (750s left) gem_exec_fence (expired-history) [272.540744] Starting subtest: expired-history [279.730471] Subtest expired-history: SUCCESS (7.191s) [280.409109] [058/133] (741s left) kms_psr (fbc-psr-sprite-plane-move) [280.520784] Starting subtest: fbc-psr-sprite-plane-move [280.523048] Starting dynamic subtest: eDP-1 [280.527048] Dynamic subtest eDP-1: SKIP (0.000s) [280.531197] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [280.618044] [059/133] (741s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [280.713227] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [287.492008] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.778s) [287.639529] [060/133] (734s left) gem_ctx_bad_destroy (double-destroy) [287.689438] Starting subtest: double-destroy [287.691749] Subtest double-destroy: SUCCESS (0.000s) [287.793890] [061/133] (734s left) syncobj_timeline (invalid-signal-illegal-handle) [287.853855] Starting subtest: invalid-signal-illegal-handle [287.856197] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [287.977632] [062/133] (734s left) kms_chamelium_hpd (common-hpd-after-suspend) [288.355924] Subtest common-hpd-after-suspend: SKIP (0.000s) [289.123660] [063/133] (733s left) kms_frontbuffer_tracking (fbc-tiling-4) [289.218279] Starting subtest: fbc-tiling-4 [293.472726] Subtest fbc-tiling-4: SUCCESS (4.257s) [294.682589] [064/133] (727s left) gem_cs_tlb (engines) [294.748160] Starting subtest: engines [294.750385] Starting dynamic subtest: rcs0 [296.957347] Dynamic subtest rcs0: SUCCESS (2.151s) [296.969241] Starting dynamic subtest: bcs0 [299.058544] Dynamic subtest bcs0: SUCCESS (2.152s) [299.070229] Starting dynamic subtest: vcs0 [301.262485] Dynamic subtest vcs0: SUCCESS (2.152s) [301.274509] Starting dynamic subtest: vcs1 [303.415467] Dynamic subtest vcs1: SUCCESS (2.152s) [303.424998] Starting dynamic subtest: vecs0 [305.569690] Dynamic subtest vecs0: SUCCESS (2.152s) [305.578905] Starting dynamic subtest: ccs0 [307.724420] Dynamic subtest ccs0: SUCCESS (2.154s) [307.726782] Subtest engines: SUCCESS (12.917s) [307.827996] [065/133] (714s left) gem_mmap_gtt (hang-busy) [307.892154] Subtest hang-busy: SKIP (0.000s) [307.951296] [066/133] (714s left) kms_psr (psr2-sprite-plane-onoff) [308.051354] Starting subtest: psr2-sprite-plane-onoff [308.053459] Starting dynamic subtest: eDP-1 [309.866937] Dynamic subtest eDP-1: SUCCESS (1.815s) [309.869205] Subtest psr2-sprite-plane-onoff: SUCCESS (1.816s) [310.718836] [067/133] (712s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [310.823722] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [311.459368] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s) [311.658095] [068/133] (711s left) kms_big_fb (y-tiled-64bpp-rotate-270) [311.776283] Starting subtest: y-tiled-64bpp-rotate-270 [311.780942] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [311.889489] [069/133] (710s left) gem_bad_reloc (negative-reloc-lut) [311.953396] Subtest negative-reloc-lut: SKIP (0.000s) [312.020966] [070/133] (710s left) gem_ctx_persistence (engines-mixed) [312.083124] Starting subtest: engines-mixed [312.085446] Starting dynamic subtest: rcs0 [312.196710] Dynamic subtest rcs0: SUCCESS (0.113s) [312.208042] Starting dynamic subtest: bcs0 [312.281886] Dynamic subtest bcs0: SUCCESS (0.083s) [312.293446] Starting dynamic subtest: vcs0 [312.374152] Dynamic subtest vcs0: SUCCESS (0.090s) [312.386538] Starting dynamic subtest: vcs1 [312.448282] Dynamic subtest vcs1: SUCCESS (0.073s) [312.458209] Starting dynamic subtest: vecs0 [312.512249] Dynamic subtest vecs0: SUCCESS (0.062s) [312.523170] Starting dynamic subtest: ccs0 [312.579520] Dynamic subtest ccs0: SUCCESS (0.065s) [312.581915] Subtest engines-mixed: SUCCESS (0.497s) [312.683124] [071/133] (710s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [312.775296] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [312.777205] Starting dynamic subtest: pipe-A [312.838664] Dynamic subtest pipe-A: SUCCESS (0.065s) [312.852289] Starting dynamic subtest: pipe-B [314.022508] Dynamic subtest pipe-B: SUCCESS (1.182s) [314.034965] Starting dynamic subtest: pipe-C [315.142488] Dynamic subtest pipe-C: SUCCESS (1.118s) [315.151334] Starting dynamic subtest: pipe-D [316.265022] Dynamic subtest pipe-D: SUCCESS (1.120s) [316.267359] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.491s) [317.433533] [072/133] (705s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [317.545274] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [317.549620] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [317.679666] [073/133] (705s left) gem_exec_schedule (semaphore-noskip) [317.756260] Starting subtest: semaphore-noskip [318.173421] Subtest semaphore-noskip: SUCCESS (0.422s) [318.544716] [074/133] (704s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [318.649088] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [318.653308] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [318.791084] [075/133] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [318.902442] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [318.906915] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [319.039324] [076/133] (704s left) kms_big_fb (4-tiled-16bpp-rotate-0) [319.138904] Starting subtest: 4-tiled-16bpp-rotate-0 [320.394891] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.257s) [320.567222] [077/133] (702s left) gem_exec_basic (basic) [320.623040] Starting subtest: basic [320.625002] Starting dynamic subtest: rcs0-smem [320.626784] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [320.636417] Starting dynamic subtest: bcs0-smem [320.638219] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [320.646951] Starting dynamic subtest: vcs0-smem [320.648673] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [320.657096] Starting dynamic subtest: vcs1-smem [320.658954] Dynamic subtest vcs1-smem: SUCCESS (0.002s) [320.667394] Starting dynamic subtest: vecs0-smem [320.669239] Dynamic subtest vecs0-smem: SUCCESS (0.003s) [320.677948] Starting dynamic subtest: ccs0-smem [320.679747] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [320.681538] Subtest basic: SUCCESS (0.019s) [322.043439] [078/133] (701s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [322.158091] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [322.162344] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [322.267878] [079/133] (701s left) gem_mmap (short-mmap) [322.328656] Subtest short-mmap: SKIP (0.000s) [322.398911] [080/133] (700s left) gem_exec_reloc (basic-gtt-wc-active) [322.463802] Subtest basic-gtt-wc-active: SKIP (0.000s) [322.549206] [081/133] (700s left) gem_ctx_shared (create-shared-gtt) [322.614782] Starting subtest: create-shared-gtt [324.766852] Subtest create-shared-gtt: SUCCESS (2.152s) [325.223522] [082/133] (698s left) gem_exec_reloc (basic-write-wc) [325.286984] Subtest basic-write-wc: SKIP (0.000s) [325.363737] [083/133] (698s left) gem_eio (wait-immediate) [325.618031] Starting subtest: wait-immediate [326.034336] Subtest wait-immediate: SUCCESS (0.415s) [326.209175] [084/133] (697s left) gem_ctx_persistence (legacy-engines-mixed) [326.294580] Starting subtest: legacy-engines-mixed [326.296501] Starting dynamic subtest: render [326.396159] Dynamic subtest render: SUCCESS (0.103s) [326.411983] Starting dynamic subtest: bsd1 [326.472380] Dynamic subtest bsd1: SUCCESS (0.073s) [326.485316] Starting dynamic subtest: bsd2 [326.548394] Dynamic subtest bsd2: SUCCESS (0.073s) [326.563177] Starting dynamic subtest: blt [326.626559] Dynamic subtest blt: SUCCESS (0.074s) [326.639631] Starting dynamic subtest: vebox [326.703364] Dynamic subtest vebox: SUCCESS (0.074s) [326.705927] Subtest legacy-engines-mixed: SUCCESS (0.412s) [326.806107] [085/133] (696s left) perf_pmu (semaphore-busy) [326.845874] Starting subtest: semaphore-busy [326.847825] Starting dynamic subtest: rcs0 [328.520587] Dynamic subtest rcs0: SUCCESS (1.669s) [328.532887] Starting dynamic subtest: bcs0 [330.152046] Dynamic subtest bcs0: SUCCESS (1.628s) [330.165392] Starting dynamic subtest: vcs0 [334.569950] Dynamic subtest vcs0: SUCCESS (4.363s) [334.582476] Starting dynamic subtest: vcs1 [340.469934] Dynamic subtest vcs1: SUCCESS (5.952s) [340.483250] Starting dynamic subtest: vecs0 [346.485530] Dynamic subtest vecs0: SUCCESS (6.014s) [346.498099] Starting dynamic subtest: ccs0 [349.559569] Dynamic subtest ccs0: SUCCESS (3.072s) [349.562811] Subtest semaphore-busy: SUCCESS (22.715s) [349.701365] [086/133] (673s left) gem_exec_schedule (pi-common) [349.881901] Starting subtest: pi-common [349.884311] Starting dynamic subtest: rcs0 [349.917398] Dynamic subtest rcs0: SUCCESS (0.040s) [349.931369] Starting dynamic subtest: bcs0 [349.964028] Dynamic subtest bcs0: SUCCESS (0.046s) [349.973946] Starting dynamic subtest: vcs0 [350.006568] Dynamic subtest vcs0: SUCCESS (0.041s) [350.018782] Starting dynamic subtest: vcs1 [350.041778] Dynamic subtest vcs1: SUCCESS (0.034s) [350.051975] Starting dynamic subtest: vecs0 [350.078762] Dynamic subtest vecs0: SUCCESS (0.036s) [350.088679] Starting dynamic subtest: ccs0 [350.112407] Dynamic subtest ccs0: SUCCESS (0.033s) [350.114773] Subtest pi-common: SUCCESS (0.236s) [350.368773] [087/133] (673s left) i915_hangman (engine-error-state-capture) [350.427244] Starting subtest: engine-error-state-capture [350.429506] Starting dynamic subtest: rcs0 [353.945826] Dynamic subtest rcs0: SUCCESS (3.518s) [353.957763] Starting dynamic subtest: bcs0 [359.962057] Dynamic subtest bcs0: SUCCESS (6.014s) [359.975250] Starting dynamic subtest: vcs0 [365.915011] Dynamic subtest vcs0: SUCCESS (5.951s) [365.927932] Starting dynamic subtest: vcs1 [370.905881] Dynamic subtest vcs1: SUCCESS (4.988s) [370.919252] Starting dynamic subtest: vecs0 [375.896913] Dynamic subtest vecs0: SUCCESS (4.988s) [375.910033] Starting dynamic subtest: ccs0 [380.953854] Dynamic subtest ccs0: SUCCESS (5.054s) [380.956542] Subtest engine-error-state-capture: SUCCESS (30.530s) [381.068519] [088/133] (642s left) syncobj_timeline (wait-for-submit-snapshot) [381.141365] Starting subtest: wait-for-submit-snapshot [381.223745] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [381.329481] [089/133] (642s left) kms_color (ctm-blue-to-red) [381.431526] Starting subtest: ctm-blue-to-red [381.433786] Starting dynamic subtest: pipe-A-eDP-1 [382.138272] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s) [382.149046] Starting dynamic subtest: pipe-B-eDP-1 [383.493002] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.354s) [383.503488] Starting dynamic subtest: pipe-C-eDP-1 [384.874159] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s) [384.888383] Starting dynamic subtest: pipe-D-eDP-1 [386.179731] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.304s) [386.182117] Subtest ctm-blue-to-red: SUCCESS (4.749s) [387.044759] [090/133] (636s left) prime_vgem (basic-gtt) [387.115797] Starting subtest: basic-gtt [387.120299] Subtest basic-gtt: SKIP (0.000s) [387.256404] [091/133] (636s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [387.367186] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [394.936037] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.571s) [395.110586] [092/133] (628s left) api_intel_allocator (default-alignment) [395.173653] Starting subtest: default-alignment [395.176092] Subtest default-alignment: SUCCESS (0.003s) [395.327732] [093/133] (628s left) i915_pm_rps (fence-order) [395.395753] Starting subtest: fence-order [398.269656] Subtest fence-order: SUCCESS (2.872s) [398.439868] [094/133] (625s left) kms_vblank (query-busy) [398.553796] Starting subtest: query-busy [398.555984] Starting dynamic subtest: pipe-A-eDP-1 [400.443286] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.890s) [400.459871] Starting dynamic subtest: pipe-D-eDP-1 [402.995658] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s) [402.997821] Subtest query-busy: SUCCESS (4.442s) [403.820171] [095/133] (620s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [403.928434] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [403.933045] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [404.053058] [096/133] (619s left) kms_addfb_basic (invalid-get-prop-any) [404.112533] Starting subtest: invalid-get-prop-any [404.114504] Subtest invalid-get-prop-any: SUCCESS (0.000s) [404.274886] [097/133] (619s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [404.367524] Starting subtest: fbc-psr2-cursor-mmap-gtt [404.369818] Starting dynamic subtest: eDP-1 [404.374072] Dynamic subtest eDP-1: SKIP (0.000s) [404.378489] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s) [404.470886] [098/133] (619s left) kms_flip (2x-blocking-absolute-wf_vblank) [404.576902] Starting subtest: 2x-blocking-absolute-wf_vblank [404.585983] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s) [404.730077] [099/133] (619s left) kms_cursor_crc (cursor-onscreen-256x85) [404.988786] Starting subtest: cursor-onscreen-256x85 [405.036860] Subtest cursor-onscreen-256x85: SKIP (0.044s) [405.264930] [100/133] (618s left) kms_flip (2x-modeset-vs-vblank-race) [405.359519] Starting subtest: 2x-modeset-vs-vblank-race [405.370635] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s) [405.511924] [101/133] (618s left) kms_atomic_interruptible (atomic-setmode) [405.603657] Starting subtest: atomic-setmode [405.605492] Starting dynamic subtest: pipe-A-eDP-1 [412.511170] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.903s) [412.513273] Subtest atomic-setmode: SUCCESS (6.905s) [413.388715] [102/133] (610s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render) [413.494466] Starting subtest: psr-argb161616f-draw-render [413.498897] Subtest psr-argb161616f-draw-render: SKIP (0.000s) [413.623964] [103/133] (610s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [413.728398] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [413.732892] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [413.846264] [104/133] (610s left) kms_plane_scaling (invalid-num-scalers) [413.956207] Starting subtest: invalid-num-scalers [413.958531] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [413.976429] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s) [413.989277] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [414.012598] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.033s) [414.022852] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [414.048748] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.034s) [414.058819] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [414.085350] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.034s) [414.087622] Subtest invalid-num-scalers: SUCCESS (0.129s) [414.208382] [105/133] (610s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [414.316785] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [414.320180] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [414.451712] [106/133] (609s left) sw_sync (alloc_fence_invalid_timeline) [414.484381] Starting subtest: alloc_fence_invalid_timeline [414.486287] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [414.559382] [107/133] (609s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [414.618448] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [414.728080] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s) [414.833111] [108/133] (609s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [414.922666] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [414.925040] Starting dynamic subtest: A-eDP1 [423.805724] Dynamic subtest A-eDP1: SUCCESS (8.881s) [423.823611] Starting dynamic subtest: B-eDP1 [432.742916] Dynamic subtest B-eDP1: SUCCESS (8.933s) [432.757585] Starting dynamic subtest: C-eDP1 [441.707165] Dynamic subtest C-eDP1: SUCCESS (8.914s) [441.718613] Starting dynamic subtest: D-eDP1 [450.641415] Dynamic subtest D-eDP1: SUCCESS (8.930s) [450.643797] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.673s) [451.847899] [109/133] (572s left) kms_addfb_basic (size-max) [451.944900] Starting subtest: size-max [451.947007] Subtest size-max: SUCCESS (0.000s) [452.080292] [110/133] (572s left) kms_cursor_crc (cursor-rapid-movement-256x256) [452.334465] Starting subtest: cursor-rapid-movement-256x256 [452.339192] Starting dynamic subtest: pipe-A-eDP-1 [452.882524] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s) [452.913936] Starting dynamic subtest: pipe-D-eDP-1 [454.151985] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s) [454.153830] Subtest cursor-rapid-movement-256x256: SUCCESS (1.815s) [455.030731] [111/133] (569s left) gem_exec_whisper (basic-queues-all) [455.100284] Starting subtest: basic-queues-all [463.634474] Subtest basic-queues-all: SUCCESS (8.532s) [463.845720] [112/133] (560s left) kms_dsc (dsc-fractional-bpp) [463.943995] Starting subtest: dsc-fractional-bpp [463.957046] Subtest dsc-fractional-bpp: SKIP (0.001s) [464.054355] [113/133] (560s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [464.151749] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [464.154007] Starting dynamic subtest: pipe-A-default-mode [464.454681] Dynamic subtest pipe-A-default-mode: SKIP (0.299s) [464.459427] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.301s) [465.269985] [114/133] (559s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [465.368989] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [465.372924] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [465.523991] [115/133] (559s left) gem_softpin (evict-prime) [465.581211] Starting subtest: evict-prime [465.583736] Starting dynamic subtest: rcs0 [466.788117] Dynamic subtest rcs0: SUCCESS (1.205s) [466.801784] Starting dynamic subtest: bcs0 [467.942165] Dynamic subtest bcs0: SUCCESS (1.151s) [467.955714] Starting dynamic subtest: vcs0 [469.984303] Dynamic subtest vcs0: SUCCESS (2.039s) [469.997496] Starting dynamic subtest: vcs1 [472.009127] Dynamic subtest vcs1: SUCCESS (2.022s) [472.022491] Starting dynamic subtest: vecs0 [473.970077] Dynamic subtest vecs0: SUCCESS (1.958s) [473.982793] Starting dynamic subtest: ccs0 [475.156239] Dynamic subtest ccs0: SUCCESS (1.184s) [475.174089] Starting dynamic subtest: all [476.946281] Dynamic subtest all: SUCCESS (1.786s) [476.948976] Subtest evict-prime: SUCCESS (11.362s) [477.051993] [116/133] (547s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [477.167537] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [477.171827] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [477.300878] [117/133] (547s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [477.403053] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [477.539999] [118/133] (547s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [477.596366] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [477.703934] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s) [477.807560] [119/133] (547s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [477.903725] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [477.908113] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [478.046842] [120/133] (547s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [478.153284] Starting subtest: fbc-1p-primscrn-cur-indfb-move [482.228683] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.077s) [483.479276] [121/133] (541s left) gem_mmap_wc (bad-size) [483.548621] Subtest bad-size: SKIP (0.000s) [483.618027] [122/133] (541s left) kms_hdr (static-toggle-suspend) [483.717914] Starting subtest: static-toggle-suspend [483.724107] Subtest static-toggle-suspend: SKIP (0.000s) [483.818007] [123/133] (541s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [483.931255] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [483.935332] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [484.073459] [124/133] (541s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [489.116247] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [489.118554] Starting dynamic subtest: pipe-A-eDP-1 [489.903139] Dynamic subtest pipe-A-eDP-1: SKIP (0.783s) [489.914184] Starting dynamic subtest: pipe-B-eDP-1 [491.045613] Dynamic subtest pipe-B-eDP-1: SKIP (1.141s) [491.050212] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.928s) [492.257293] [125/133] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [492.350383] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [492.354493] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [492.489962] [126/133] (532s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [492.596923] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [492.599183] Starting dynamic subtest: pipe-A-eDP-1 [492.619990] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [492.631196] Starting dynamic subtest: pipe-B-eDP-1 [492.650298] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [492.659923] Starting dynamic subtest: pipe-C-eDP-1 [492.677218] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [492.686976] Starting dynamic subtest: pipe-D-eDP-1 [492.705988] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [492.707899] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.018s) [494.920421] [127/133] (530s left) syncobj_timeline (single-wait-all-available-submitted) [494.984870] Starting subtest: single-wait-all-available-submitted [494.987032] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [495.117905] [128/133] (530s left) gem_exec_parallel (userptr) [495.178985] Starting subtest: userptr [495.181335] Starting dynamic subtest: rcs0 [496.642750] Dynamic subtest rcs0: SUCCESS (1.463s) [496.653421] Starting dynamic subtest: bcs0 [498.121519] Dynamic subtest bcs0: SUCCESS (1.476s) [498.134205] Starting dynamic subtest: vcs0 [499.983965] Dynamic subtest vcs0: SUCCESS (1.859s) [499.995904] Starting dynamic subtest: vcs1 [501.948028] Dynamic subtest vcs1: SUCCESS (1.963s) [501.958944] Starting dynamic subtest: vecs0 [503.931794] Dynamic subtest vecs0: SUCCESS (1.981s) [503.944438] Starting dynamic subtest: ccs0 [505.455684] Dynamic subtest ccs0: SUCCESS (1.522s) [505.458744] Subtest userptr: SUCCESS (10.275s) [505.668063] [129/133] (519s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [505.772424] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [505.776823] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [505.905175] [130/133] (519s left) i915_selftest (mock) [507.903762] Starting subtest: mock [507.906282] Starting dynamic subtest: sanitycheck [508.639163] Dynamic subtest sanitycheck: SUCCESS (0.735s) [508.649007] Starting dynamic subtest: shmem [509.411919] Dynamic subtest shmem: SUCCESS (0.770s) [509.428140] Starting dynamic subtest: fence [517.196288] Dynamic subtest fence: SUCCESS (7.780s) [517.206395] Starting dynamic subtest: scatterlist [518.913667] Dynamic subtest scatterlist: SUCCESS (1.715s) [518.924206] Starting dynamic subtest: syncmap [522.411162] Dynamic subtest syncmap: SUCCESS (3.494s) [522.421721] Starting dynamic subtest: uncore [523.110051] Dynamic subtest uncore: SUCCESS (0.697s) [523.126797] Starting dynamic subtest: ring [523.860048] Dynamic subtest ring: SUCCESS (0.747s) [523.869326] Starting dynamic subtest: engine [524.597079] Dynamic subtest engine: SUCCESS (0.734s) [524.606396] Starting dynamic subtest: timelines [528.651293] Dynamic subtest timelines: SUCCESS (4.050s) [528.661537] Starting dynamic subtest: requests [532.113789] Dynamic subtest requests: SUCCESS (3.460s) [532.123718] Starting dynamic subtest: objects [533.051473] Dynamic subtest objects: SUCCESS (0.936s) [533.083509] Starting dynamic subtest: phys [533.983342] Dynamic subtest phys: SUCCESS (0.930s) [533.992983] Starting dynamic subtest: dmabuf [534.904145] Dynamic subtest dmabuf: SUCCESS (0.919s) [534.914230] Starting dynamic subtest: vma [540.383168] Dynamic subtest vma: SUCCESS (5.475s) [540.393034] Starting dynamic subtest: evict [541.859086] Dynamic subtest evict: SUCCESS (1.474s) [541.869027] Starting dynamic subtest: gtt [545.174930] Dynamic subtest gtt: SUCCESS (3.313s) [545.185154] Starting dynamic subtest: hugepages [546.202726] Dynamic subtest hugepages: SUCCESS (1.025s) [546.212944] Starting dynamic subtest: memory_region [548.952891] Dynamic subtest memory_region: SUCCESS (2.747s) [548.955427] Subtest mock: SUCCESS (41.041s) [548.984903] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [548.985590] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [548.988647] [131/133] (476s left) gem_mmap_gtt (basic-write-read) [550.559590] Subtest basic-write-read: SKIP (0.000s) [550.634803] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [550.636097] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true [550.640028] [132/133] (474s left) perf (gen12-group-exclusive-stream-sample-oa) [550.775864] Starting subtest: gen12-group-exclusive-stream-sample-oa [550.795817] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.021s) [550.837971] [133/133] (474s left) perf_pmu (busy-double-start) [550.874421] Starting subtest: busy-double-start [550.876307] Starting dynamic subtest: rcs0 [554.521620] Dynamic subtest rcs0: FAIL (3.597s) [554.532873] Starting dynamic subtest: bcs0 [558.044606] Dynamic subtest bcs0: SUCCESS (3.573s) [558.055927] Starting dynamic subtest: vcs0 [562.528643] Dynamic subtest vcs0: SUCCESS (4.481s) [562.539995] Starting dynamic subtest: vcs1 [566.562728] Dynamic subtest vcs1: SUCCESS (4.031s) [566.574161] Starting dynamic subtest: vecs0 [570.525646] Dynamic subtest vecs0: SUCCESS (3.960s) [570.537276] Starting dynamic subtest: ccs0 [574.163223] Dynamic subtest ccs0: FAIL (3.565s) [574.165254] Subtest busy-double-start: FAIL (23.216s) [574.243584] Closing watchdogs results: parsing output: 0/ for test: gem_partial_pwrite_pread results: parsing output: 1/ for test: kms_content_protection results: parsing output: 2/ for test: kms_rotation_crc results: parsing output: 3/ for test: kms_chamelium_color results: parsing output: 4/ for test: syncobj_wait results: parsing output: 5/ for test: kms_pipe_crc_basic results: parsing output: 6/ for test: gem_set_tiling_vs_blt results: parsing output: 7/ for test: syncobj_wait results: parsing output: 8/ for test: syncobj_wait results: parsing output: 9/ for test: gem_pxp results: parsing output: 10/ for test: kms_cursor_legacy results: parsing output: 11/ for test: kms_rotation_crc results: parsing output: 12/ for test: syncobj_wait results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: gem_softpin results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_ctx_param results: parsing output: 17/ for test: syncobj_wait results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: gem_mmap_gtt results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: kms_flip results: parsing output: 23/ for test: kms_plane_cursor results: parsing output: 24/ for test: kms_cdclk results: parsing output: 25/ for test: gem_exec_balancer results: parsing output: 26/ for test: kms_cursor_legacy results: parsing output: 27/ for test: kms_flip_scaled_crc results: parsing output: 28/ for test: kms_flip_scaled_crc results: parsing output: 29/ for test: core_getstats results: parsing output: 30/ for test: kms_rmfb results: parsing output: 31/ for test: gem_exec_reloc results: parsing output: 32/ for test: kms_properties results: parsing output: 33/ for test: kms_invalid_mode results: parsing output: 34/ for test: kms_plane_scaling results: parsing output: 35/ for test: kms_pm_rpm results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_dirtyfb results: parsing output: 38/ for test: kms_cursor_legacy results: parsing output: 39/ for test: syncobj_timeline results: parsing output: 40/ for test: kms_prime results: parsing output: 41/ for test: kms_pipe_b_c_ivb results: parsing output: 42/ for test: i915_drm_fdinfo results: parsing output: 43/ for test: gem_userptr_blits results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_scaling_modes results: parsing output: 47/ for test: kms_psr results: parsing output: 48/ for test: gem_ringfill results: parsing output: 49/ for test: gem_exec_whisper results: parsing output: 50/ for test: api_intel_bb results: parsing output: 51/ for test: kms_cursor_crc results: parsing output: 52/ for test: kms_ccs results: parsing output: 53/ for test: gen9_exec_parse results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: gem_exec_fence results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_ctx_bad_destroy results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_chamelium_hpd results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: gem_cs_tlb results: parsing output: 64/ for test: gem_mmap_gtt results: parsing output: 65/ for test: kms_psr results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: gem_bad_reloc results: parsing output: 69/ for test: gem_ctx_persistence results: parsing output: 70/ for test: kms_plane_scaling results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_exec_schedule results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_big_fb results: parsing output: 76/ for test: gem_exec_basic results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_mmap results: parsing output: 79/ for test: gem_exec_reloc results: parsing output: 80/ for test: gem_ctx_shared results: parsing output: 81/ for test: gem_exec_reloc results: parsing output: 82/ for test: gem_eio results: parsing output: 83/ for test: gem_ctx_persistence results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: i915_hangman results: parsing output: 87/ for test: syncobj_timeline results: parsing output: 88/ for test: kms_color results: parsing output: 89/ for test: prime_vgem results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: api_intel_allocator results: parsing output: 92/ for test: i915_pm_rps results: parsing output: 93/ for test: kms_vblank results: parsing output: 94/ for test: kms_big_fb results: parsing output: 95/ for test: kms_addfb_basic results: parsing output: 96/ for test: kms_psr results: parsing output: 97/ for test: kms_flip results: parsing output: 98/ for test: kms_cursor_crc results: parsing output: 99/ for test: kms_flip results: parsing output: 100/ for test: kms_atomic_interruptible results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_plane_scaling results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: sw_sync results: parsing output: 106/ for test: syncobj_timeline results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: kms_addfb_basic results: parsing output: 109/ for test: kms_cursor_crc results: parsing output: 110/ for test: gem_exec_whisper results: parsing output: 111/ for test: kms_dsc results: parsing output: 112/ for test: kms_flip_scaled_crc results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_softpin results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_addfb_basic results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_mmap_wc results: parsing output: 121/ for test: kms_hdr results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_psr2_sf results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_ccs results: parsing output: 126/ for test: syncobj_timeline results: parsing output: 127/ for test: gem_exec_parallel results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: i915_selftest results: parsing output: 130/ for test: gem_mmap_gtt results: parsing output: 131/ for test: perf results: parsing output: 132/ for test: perf_pmu Done.