[56.342665] Initializing watchdogs [56.342711] /dev/watchdog0 [56.357276] [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] [56.361678] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.364128] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.367621] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop) [56.462515] Subtest write-snoop: SKIP (0.000s) [56.556440] [002/133] (960s left) kms_content_protection (content-type-change) [56.718575] Starting subtest: content-type-change [56.722886] Subtest content-type-change: SKIP (0.000s) [56.889691] [003/133] (960s left) kms_rotation_crc (multiplane-rotation) [56.982236] Starting subtest: multiplane-rotation [74.507718] Subtest multiplane-rotation: SUCCESS (17.504s) [74.655815] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue) [74.769580] Subtest ctm-red-to-blue: SKIP (0.000s) [74.815413] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle) [74.878455] Starting subtest: invalid-reset-one-illegal-handle [74.880531] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [75.009225] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc) [75.117502] Starting subtest: disable-crc-after-crtc [75.119193] Starting dynamic subtest: pipe-A-eDP-1 [76.795597] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.677s) [76.804382] Starting dynamic subtest: pipe-B-eDP-1 [79.150139] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.350s) [79.159210] Starting dynamic subtest: pipe-C-eDP-1 [81.420128] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.269s) [81.429304] Starting dynamic subtest: pipe-D-eDP-1 [83.688274] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.265s) [83.690643] Subtest disable-crc-after-crtc: SUCCESS (8.567s) [84.532263] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled) [84.601981] Subtest tiled-to-tiled: SKIP (0.000s) [84.668257] [008/133] (932s left) syncobj_wait (wait-all-interrupted) [84.727851] Starting subtest: wait-all-interrupted [84.828212] Subtest wait-all-interrupted: SUCCESS (0.102s) [84.929280] [009/133] (932s left) syncobj_wait (wait-all-complex) [84.994309] Starting subtest: wait-all-complex [85.207665] Subtest wait-all-complex: SUCCESS (0.213s) [85.303731] [010/133] (931s left) gem_pxp (reject-modify-context-protection-on) [85.426827] Starting subtest: reject-modify-context-protection-on [85.429509] Subtest reject-modify-context-protection-on: SUCCESS (0.002s) [85.556101] [011/133] (931s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [85.683213] Starting subtest: cursorA-vs-flipB-varying-size [85.687572] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [85.846735] [012/133] (931s left) kms_rotation_crc (primary-rotation-90) [85.938942] Starting subtest: primary-rotation-90 [85.943409] Subtest primary-rotation-90: SKIP (0.001s) [86.033892] [013/133] (931s left) syncobj_wait (reset-multiple-signaled) [86.089775] Starting subtest: reset-multiple-signaled [86.092079] Subtest reset-multiple-signaled: SUCCESS (0.000s) [86.209443] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs) [86.304783] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs [86.308754] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s) [87.456831] [015/133] (929s left) gem_softpin (noreloc-s3) [87.527588] Starting subtest: noreloc-S3 [108.164279] Subtest noreloc-S3: SUCCESS (5.391s) [108.310211] [016/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [108.430977] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [113.001775] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.544s) [114.216908] [017/133] (903s left) gem_ctx_param (invalid-ctx-set) [114.270546] Starting subtest: invalid-ctx-set [114.273476] Subtest invalid-ctx-set: SUCCESS (0.001s) [114.400215] [018/133] (903s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [114.457457] Starting subtest: single-wait-all-for-submit-unsubmitted [114.564434] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s) [114.664767] [019/133] (902s left) kms_big_fb (x-tiled-64bpp-rotate-90) [114.777385] Starting subtest: x-tiled-64bpp-rotate-90 [114.797117] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s) [114.955111] [020/133] (902s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [115.021390] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [115.084923] [021/133] (902s left) kms_psr (fbc-psr-cursor-plane-move) [115.173460] Starting subtest: fbc-psr-cursor-plane-move [115.176068] Starting dynamic subtest: eDP-1 [115.181191] Dynamic subtest eDP-1: SKIP (0.000s) [115.186279] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [115.267527] [022/133] (902s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [115.371947] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [116.398650] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.023s) [116.546620] [023/133] (901s left) kms_flip (2x-flip-vs-rmfb) [116.649099] Starting subtest: 2x-flip-vs-rmfb [116.657212] Subtest 2x-flip-vs-rmfb: SKIP (0.011s) [116.784946] [024/133] (900s left) kms_plane_cursor (viewport) [116.869842] Starting subtest: viewport [116.875025] Starting dynamic subtest: pipe-A-eDP-1-size-64 [119.478215] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.599s) [119.538473] Starting dynamic subtest: pipe-A-eDP-1-size-128 [122.130277] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.593s) [122.189207] Starting dynamic subtest: pipe-A-eDP-1-size-256 [124.768866] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.582s) [125.128341] Starting dynamic subtest: pipe-B-eDP-1-size-64 [128.367069] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.247s) [128.426047] Starting dynamic subtest: pipe-B-eDP-1-size-128 [130.938384] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.515s) [130.997624] Starting dynamic subtest: pipe-B-eDP-1-size-256 [133.497471] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.504s) [133.845816] Starting dynamic subtest: pipe-C-eDP-1-size-64 [136.705291] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.870s) [136.742160] Starting dynamic subtest: pipe-C-eDP-1-size-128 [139.069157] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.334s) [139.111876] Starting dynamic subtest: pipe-C-eDP-1-size-256 [141.337473] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.234s) [141.667630] Starting dynamic subtest: pipe-D-eDP-1-size-64 [144.586229] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.930s) [144.623192] Starting dynamic subtest: pipe-D-eDP-1-size-128 [146.843323] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.224s) [146.879388] Starting dynamic subtest: pipe-D-eDP-1-size-256 [149.021542] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s) [149.341271] Subtest viewport: SUCCESS (32.442s) [150.167381] [025/133] (867s left) kms_cdclk (mode-transition) [150.264134] Starting subtest: mode-transition [150.266595] Starting dynamic subtest: pipe-A-eDP-1 [150.561488] Dynamic subtest pipe-A-eDP-1: SKIP (0.291s) [150.571417] Starting dynamic subtest: pipe-B-eDP-1 [150.576968] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [150.585803] Starting dynamic subtest: pipe-C-eDP-1 [150.591636] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [150.600598] Starting dynamic subtest: pipe-D-eDP-1 [150.606044] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [150.611327] Subtest mode-transition: SKIP (0.299s) [151.403135] [026/133] (866s left) gem_exec_balancer (fairslice) [151.462177] Starting subtest: fairslice [154.354920] Subtest fairslice: SUCCESS (2.892s) [155.175106] [027/133] (862s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [155.294248] Starting subtest: basic-flip-before-cursor-varying-size [156.218968] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.926s) [157.048940] [028/133] (860s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [157.138259] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [157.140749] Starting dynamic subtest: pipe-A-default-mode [157.431142] Dynamic subtest pipe-A-default-mode: SKIP (0.291s) [157.436343] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.293s) [158.275461] [029/133] (859s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [158.373635] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [158.376597] Starting dynamic subtest: pipe-A-default-mode [161.116492] Dynamic subtest pipe-A-default-mode: SUCCESS (2.743s) [161.119248] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.745s) [161.971009] [030/133] (856s left) core_getstats (basic) [162.033496] Starting subtest: basic [162.036388] Subtest basic: SUCCESS (0.000s) [162.149181] [031/133] (855s left) kms_rmfb (close-fd) [162.255379] Starting subtest: close-fd [162.257405] Starting dynamic subtest: pipe-A-eDP-1 [162.363531] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s) [162.374185] Starting dynamic subtest: pipe-B-eDP-1 [163.525964] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.161s) [163.535774] Starting dynamic subtest: pipe-C-eDP-1 [164.641646] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s) [164.659437] Starting dynamic subtest: pipe-D-eDP-1 [165.774773] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [165.777133] Subtest close-fd: SUCCESS (3.521s) [167.004118] [032/133] (851s left) gem_exec_reloc (basic-gtt-wc) [167.065625] Subtest basic-gtt-wc: SKIP (0.000s) [167.140543] [033/133] (851s left) kms_properties (crtc-properties-legacy) [167.229146] Starting subtest: crtc-properties-legacy [167.231607] Starting dynamic subtest: pipe-A-eDP-1 [167.666542] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.437s) [167.676534] Starting dynamic subtest: pipe-B-eDP-1 [168.840935] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.171s) [168.850609] Starting dynamic subtest: pipe-C-eDP-1 [169.972091] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.132s) [169.981643] Starting dynamic subtest: pipe-D-eDP-1 [171.100240] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s) [171.102910] Subtest crtc-properties-legacy: SUCCESS (3.871s) [171.937368] [034/133] (846s left) kms_invalid_mode (zero-hdisplay) [172.045012] Starting subtest: zero-hdisplay [172.047390] Starting dynamic subtest: pipe-A-eDP-1 [172.335595] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s) [172.344634] Starting dynamic subtest: pipe-B-eDP-1 [172.347383] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [172.356106] Starting dynamic subtest: pipe-C-eDP-1 [172.358463] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [172.366659] Starting dynamic subtest: pipe-D-eDP-1 [172.369065] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [172.371294] Subtest zero-hdisplay: SUCCESS (0.299s) [173.160508] [035/133] (845s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [173.260852] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [173.263484] Starting dynamic subtest: pipe-A [174.330305] Dynamic subtest pipe-A: SUCCESS (1.072s) [174.342248] Starting dynamic subtest: pipe-B [176.460321] Dynamic subtest pipe-B: SUCCESS (2.126s) [176.469204] Starting dynamic subtest: pipe-C [177.652642] Dynamic subtest pipe-C: SUCCESS (1.190s) [177.662158] Starting dynamic subtest: pipe-D [178.879246] Dynamic subtest pipe-D: SUCCESS (1.224s) [178.882166] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.620s) [180.091952] [036/133] (838s left) kms_pm_rpm (legacy-planes-dpms) [182.343918] Starting subtest: legacy-planes-dpms [182.347033] Starting dynamic subtest: plane-63 [190.941154] Dynamic subtest plane-63: SUCCESS (8.593s) [190.952757] Starting dynamic subtest: plane-93 [199.359150] Dynamic subtest plane-93: SUCCESS (8.412s) [199.371154] Starting dynamic subtest: plane-123 [207.978898] Dynamic subtest plane-123: SUCCESS (8.618s) [207.991604] Starting dynamic subtest: plane-133 [216.575606] Dynamic subtest plane-133: SUCCESS (8.595s) [216.578670] Subtest legacy-planes-dpms: SUCCESS (34.229s) [216.995478] [037/133] (801s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [217.100306] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [217.105234] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [217.237120] [038/133] (801s left) kms_dirtyfb (default-dirtyfb-ioctl) [217.337629] Starting subtest: default-dirtyfb-ioctl [217.339908] Starting dynamic subtest: A-eDP-1 [218.925010] Dynamic subtest A-eDP-1: SUCCESS (1.587s) [218.927641] Subtest default-dirtyfb-ioctl: SUCCESS (1.588s) [219.817868] [039/133] (798s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [219.947353] Starting subtest: cursorB-vs-flipA-legacy [219.952519] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s) [220.112854] [040/133] (798s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [220.180466] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [220.183389] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s) [220.311454] [041/133] (798s left) kms_prime (basic-crc-vgem) [220.456852] Starting subtest: basic-crc-vgem [220.459403] Starting dynamic subtest: second-to-first [221.485915] Dynamic subtest second-to-first: SUCCESS (1.031s) [221.488269] Subtest basic-crc-vgem: SUCCESS (1.032s) [221.590682] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true [221.594258] [042/133] (796s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [221.701210] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [221.771940] [043/133] (796s left) i915_drm_fdinfo (busy) [221.814940] Starting subtest: busy [221.817180] Starting dynamic subtest: rcs0 [221.837187] Dynamic subtest rcs0: SKIP (0.021s) [221.847354] Starting dynamic subtest: bcs0 [221.861454] Dynamic subtest bcs0: SKIP (0.024s) [221.870502] Starting dynamic subtest: vcs0 [221.875398] Dynamic subtest vcs0: SKIP (0.000s) [221.884346] Starting dynamic subtest: vcs1 [221.888539] Dynamic subtest vcs1: SKIP (0.000s) [221.897923] Starting dynamic subtest: vecs0 [221.902370] Dynamic subtest vecs0: SKIP (0.000s) [221.911375] Starting dynamic subtest: ccs0 [221.916358] Dynamic subtest ccs0: SKIP (0.000s) [221.921012] Subtest busy: SKIP (0.051s) [221.961732] [044/133] (796s left) gem_userptr_blits (nohangcheck) [222.033412] Starting subtest: nohangcheck [222.313667] Subtest nohangcheck: SUCCESS (0.279s) [222.467241] [045/133] (796s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [222.571547] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [223.185021] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.615s) [223.392118] [046/133] (795s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [223.495094] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [223.499841] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [224.649999] [047/133] (794s left) kms_scaling_modes (scaling-mode-full) [224.743248] Starting subtest: scaling-mode-full [224.745620] Starting dynamic subtest: pipe-A-eDP-1 [224.840511] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.099s) [224.853616] Starting dynamic subtest: pipe-B-eDP-1 [226.050059] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.206s) [226.059660] Starting dynamic subtest: pipe-C-eDP-1 [227.149073] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.097s) [227.162271] Starting dynamic subtest: pipe-D-eDP-1 [228.276180] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s) [228.278647] Subtest scaling-mode-full: SUCCESS (3.536s) [229.450216] [048/133] (789s left) kms_psr (fbc-pr-basic) [229.554795] Starting subtest: fbc-pr-basic [229.559751] Subtest fbc-pr-basic: SKIP (0.000s) [229.655414] [049/133] (789s left) gem_ringfill (basic-all) [235.131476] Starting subtest: basic-all [236.297793] Subtest basic-all: SUCCESS (1.165s) [236.478600] [050/133] (782s left) gem_exec_whisper (basic-fds-forked-all) [236.548997] Starting subtest: basic-fds-forked-all [260.368866] Subtest basic-fds-forked-all: SUCCESS (23.814s) [260.577462] [051/133] (758s left) api_intel_bb (full-batch) [260.640388] Starting subtest: full-batch [260.652737] Subtest full-batch: SUCCESS (0.014s) [260.822677] [052/133] (758s left) kms_cursor_crc (cursor-sliding-256x85) [261.066327] Starting subtest: cursor-sliding-256x85 [261.112299] Subtest cursor-sliding-256x85: SKIP (0.041s) [261.329827] [053/133] (757s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [261.433305] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [261.435879] Starting dynamic subtest: pipe-A-eDP-1 [261.505776] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [261.516875] Starting dynamic subtest: pipe-B-eDP-1 [261.579336] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [261.589618] Starting dynamic subtest: pipe-C-eDP-1 [261.648408] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [261.658631] Starting dynamic subtest: pipe-D-eDP-1 [261.716187] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [261.720868] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s) [263.620737] [054/133] (755s left) gen9_exec_parse (allowed-single) [263.690499] Subtest allowed-single: SKIP (0.000s) [263.776830] [055/133] (755s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [263.880371] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [270.990516] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.112s) [271.162560] [056/133] (747s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [271.261460] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [271.266535] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [271.392848] [057/133] (747s left) gem_exec_fence (expired-history) [271.914105] Starting subtest: expired-history [278.834305] Subtest expired-history: SUCCESS (6.920s) [279.586847] [058/133] (739s left) kms_psr (fbc-psr-sprite-plane-move) [279.691604] Starting subtest: fbc-psr-sprite-plane-move [279.694221] Starting dynamic subtest: eDP-1 [279.699383] Dynamic subtest eDP-1: SKIP (0.000s) [279.704421] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [279.790184] [059/133] (739s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [279.895408] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [286.812733] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.918s) [286.961966] [060/133] (732s left) gem_ctx_bad_destroy (double-destroy) [287.021079] Starting subtest: double-destroy [287.023766] Subtest double-destroy: SUCCESS (0.000s) [287.130192] [061/133] (732s left) syncobj_timeline (invalid-signal-illegal-handle) [287.192170] Starting subtest: invalid-signal-illegal-handle [287.194788] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [287.336916] [062/133] (732s left) kms_chamelium_hpd (common-hpd-after-suspend) [287.723491] Subtest common-hpd-after-suspend: SKIP (0.000s) [288.574320] [063/133] (730s left) kms_frontbuffer_tracking (fbc-tiling-4) [288.679165] Starting subtest: fbc-tiling-4 [292.986771] Subtest fbc-tiling-4: SUCCESS (4.310s) [294.136603] [064/133] (725s left) gem_cs_tlb (engines) [294.188418] Starting subtest: engines [294.191151] Starting dynamic subtest: rcs0 [296.344878] Dynamic subtest rcs0: SUCCESS (2.152s) [296.357999] Starting dynamic subtest: bcs0 [298.499601] Dynamic subtest bcs0: SUCCESS (2.153s) [298.512614] Starting dynamic subtest: vcs0 [300.653629] Dynamic subtest vcs0: SUCCESS (2.153s) [300.664030] Starting dynamic subtest: vcs1 [302.809612] Dynamic subtest vcs1: SUCCESS (2.153s) [302.822593] Starting dynamic subtest: vecs0 [304.964264] Dynamic subtest vecs0: SUCCESS (2.153s) [304.973921] Starting dynamic subtest: ccs0 [307.118491] Dynamic subtest ccs0: SUCCESS (2.154s) [307.120998] Subtest engines: SUCCESS (12.924s) [307.281521] [065/133] (712s left) gem_mmap_gtt (hang-busy) [307.340533] Subtest hang-busy: SKIP (0.000s) [307.401250] [066/133] (712s left) kms_psr (psr2-sprite-plane-onoff) [307.504552] Starting subtest: psr2-sprite-plane-onoff [307.507455] Starting dynamic subtest: eDP-1 [309.227174] Dynamic subtest eDP-1: SUCCESS (1.722s) [309.229905] Subtest psr2-sprite-plane-onoff: SUCCESS (1.723s) [310.083633] [067/133] (709s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [310.197130] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [310.832081] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s) [311.038279] [068/133] (708s left) kms_big_fb (y-tiled-64bpp-rotate-270) [311.150189] Starting subtest: y-tiled-64bpp-rotate-270 [311.155452] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [311.300168] [069/133] (708s left) gem_bad_reloc (negative-reloc-lut) [311.362608] Subtest negative-reloc-lut: SKIP (0.000s) [311.451014] [070/133] (708s left) gem_ctx_persistence (engines-mixed) [311.509081] Starting subtest: engines-mixed [311.511624] Starting dynamic subtest: rcs0 [311.602270] Dynamic subtest rcs0: SUCCESS (0.093s) [311.615454] Starting dynamic subtest: bcs0 [311.633538] Dynamic subtest bcs0: SUCCESS (0.029s) [311.643591] Starting dynamic subtest: vcs0 [311.713794] Dynamic subtest vcs0: SUCCESS (0.079s) [311.724995] Starting dynamic subtest: vcs1 [311.767224] Dynamic subtest vcs1: SUCCESS (0.052s) [311.780343] Starting dynamic subtest: vecs0 [311.843646] Dynamic subtest vecs0: SUCCESS (0.075s) [311.856015] Starting dynamic subtest: ccs0 [311.927520] Dynamic subtest ccs0: SUCCESS (0.082s) [311.930095] Subtest engines-mixed: SUCCESS (0.420s) [312.031065] [071/133] (707s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [312.120470] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [312.122965] Starting dynamic subtest: pipe-A [312.185932] Dynamic subtest pipe-A: SUCCESS (0.067s) [312.195400] Starting dynamic subtest: pipe-B [313.289375] Dynamic subtest pipe-B: SUCCESS (1.102s) [313.301590] Starting dynamic subtest: pipe-C [314.397212] Dynamic subtest pipe-C: SUCCESS (1.105s) [314.407546] Starting dynamic subtest: pipe-D [315.524996] Dynamic subtest pipe-D: SUCCESS (1.127s) [315.527477] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.405s) [316.700137] [072/133] (703s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [316.810891] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [316.816281] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [316.945193] [073/133] (702s left) gem_exec_schedule (semaphore-noskip) [317.019440] Starting subtest: semaphore-noskip [317.438924] Subtest semaphore-noskip: SUCCESS (0.430s) [318.197849] [074/133] (701s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [318.304281] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [318.309260] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [318.434173] [075/133] (701s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [318.545459] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [318.550539] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [318.682117] [076/133] (701s left) kms_big_fb (4-tiled-16bpp-rotate-0) [318.787037] Starting subtest: 4-tiled-16bpp-rotate-0 [320.069002] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.280s) [320.229169] [077/133] (699s left) gem_exec_basic (basic) [320.295094] Starting subtest: basic [320.297205] Starting dynamic subtest: rcs0-smem [320.299715] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [320.310663] Starting dynamic subtest: bcs0-smem [320.312864] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [320.322306] Starting dynamic subtest: vcs0-smem [320.324296] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [320.333948] Starting dynamic subtest: vcs1-smem [320.336175] Dynamic subtest vcs1-smem: SUCCESS (0.002s) [320.346643] Starting dynamic subtest: vecs0-smem [320.348685] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [320.357747] Starting dynamic subtest: ccs0-smem [320.359646] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [320.361442] Subtest basic: SUCCESS (0.016s) [322.170125] [078/133] (697s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [322.273617] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [322.279405] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [322.415100] [079/133] (697s left) gem_mmap (short-mmap) [322.484032] Subtest short-mmap: SKIP (0.000s) [322.552416] [080/133] (697s left) gem_exec_reloc (basic-gtt-wc-active) [322.614631] Subtest basic-gtt-wc-active: SKIP (0.000s) [322.704228] [081/133] (697s left) gem_ctx_shared (create-shared-gtt) [322.770496] Starting subtest: create-shared-gtt [324.923395] Subtest create-shared-gtt: SUCCESS (2.151s) [325.328305] [082/133] (694s left) gem_exec_reloc (basic-write-wc) [325.398599] Subtest basic-write-wc: SKIP (0.000s) [325.469650] [083/133] (694s left) gem_eio (wait-immediate) [325.709390] Starting subtest: wait-immediate [326.125017] Subtest wait-immediate: SUCCESS (0.416s) [326.299182] [084/133] (694s left) gem_ctx_persistence (legacy-engines-mixed) [326.364651] Starting subtest: legacy-engines-mixed [326.367030] Starting dynamic subtest: render [326.485143] Dynamic subtest render: SUCCESS (0.122s) [326.500023] Starting dynamic subtest: bsd1 [326.555168] Dynamic subtest bsd1: SUCCESS (0.066s) [326.569828] Starting dynamic subtest: bsd2 [326.639622] Dynamic subtest bsd2: SUCCESS (0.081s) [326.654909] Starting dynamic subtest: blt [326.727461] Dynamic subtest blt: SUCCESS (0.085s) [326.742290] Starting dynamic subtest: vebox [326.793493] Dynamic subtest vebox: SUCCESS (0.063s) [326.796061] Subtest legacy-engines-mixed: SUCCESS (0.432s) [326.898159] [085/133] (693s left) perf_pmu (semaphore-busy) [326.949057] Starting subtest: semaphore-busy [326.951162] Starting dynamic subtest: rcs0 [328.615932] Dynamic subtest rcs0: SUCCESS (1.664s) [328.627298] Starting dynamic subtest: bcs0 [330.249403] Dynamic subtest bcs0: SUCCESS (1.632s) [330.260681] Starting dynamic subtest: vcs0 [334.641621] Dynamic subtest vcs0: SUCCESS (4.392s) [334.652484] Starting dynamic subtest: vcs1 [340.594584] Dynamic subtest vcs1: SUCCESS (5.953s) [340.607337] Starting dynamic subtest: vecs0 [346.612696] Dynamic subtest vecs0: SUCCESS (6.016s) [346.626451] Starting dynamic subtest: ccs0 [349.685518] Dynamic subtest ccs0: SUCCESS (3.071s) [349.689095] Subtest semaphore-busy: SUCCESS (22.743s) [349.846043] [086/133] (670s left) gem_exec_schedule (pi-common) [350.056535] Starting subtest: pi-common [350.059560] Starting dynamic subtest: rcs0 [350.109242] Dynamic subtest rcs0: SUCCESS (0.054s) [350.120367] Starting dynamic subtest: bcs0 [350.152703] Dynamic subtest bcs0: SUCCESS (0.042s) [350.163537] Starting dynamic subtest: vcs0 [350.194583] Dynamic subtest vcs0: SUCCESS (0.041s) [350.205330] Starting dynamic subtest: vcs1 [350.234032] Dynamic subtest vcs1: SUCCESS (0.038s) [350.244987] Starting dynamic subtest: vecs0 [350.268181] Dynamic subtest vecs0: SUCCESS (0.034s) [350.279216] Starting dynamic subtest: ccs0 [350.302974] Dynamic subtest ccs0: SUCCESS (0.034s) [350.305668] Subtest pi-common: SUCCESS (0.249s) [350.549838] [087/133] (669s left) i915_hangman (engine-error-state-capture) [350.624882] Starting subtest: engine-error-state-capture [350.627444] Starting dynamic subtest: rcs0 [354.071336] Dynamic subtest rcs0: SUCCESS (3.448s) [354.085986] Starting dynamic subtest: bcs0 [360.086147] Dynamic subtest bcs0: SUCCESS (6.013s) [360.100346] Starting dynamic subtest: vcs0 [366.039128] Dynamic subtest vcs0: SUCCESS (5.951s) [366.052946] Starting dynamic subtest: vcs1 [372.055594] Dynamic subtest vcs1: SUCCESS (6.014s) [372.070085] Starting dynamic subtest: vecs0 [378.071125] Dynamic subtest vecs0: SUCCESS (6.013s) [378.085639] Starting dynamic subtest: ccs0 [384.086860] Dynamic subtest ccs0: SUCCESS (6.013s) [384.089905] Subtest engine-error-state-capture: SUCCESS (33.469s) [384.195166] [088/133] (636s left) syncobj_timeline (wait-for-submit-snapshot) [384.261691] Starting subtest: wait-for-submit-snapshot [384.342287] Subtest wait-for-submit-snapshot: SUCCESS (0.083s) [384.447803] [089/133] (636s left) kms_color (ctm-blue-to-red) [384.547652] Starting subtest: ctm-blue-to-red [384.550662] Starting dynamic subtest: pipe-A-eDP-1 [385.230604] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.680s) [385.242046] Starting dynamic subtest: pipe-B-eDP-1 [386.642237] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.412s) [386.652964] Starting dynamic subtest: pipe-C-eDP-1 [387.967280] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.325s) [387.978758] Starting dynamic subtest: pipe-D-eDP-1 [389.314457] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s) [389.316872] Subtest ctm-blue-to-red: SUCCESS (4.767s) [390.143366] [090/133] (630s left) prime_vgem (basic-gtt) [390.234654] Starting subtest: basic-gtt [390.240632] Subtest basic-gtt: SKIP (0.000s) [390.380014] [091/133] (630s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [390.484530] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [398.044661] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.562s) [398.216198] [092/133] (622s left) api_intel_allocator (default-alignment) [398.281427] Starting subtest: default-alignment [398.284547] Subtest default-alignment: SUCCESS (0.003s) [398.448941] [093/133] (622s left) i915_pm_rps (fence-order) [398.516589] Starting subtest: fence-order [401.409030] Subtest fence-order: SUCCESS (2.890s) [401.559853] [094/133] (619s left) kms_vblank (query-busy) [401.667619] Starting subtest: query-busy [401.669998] Starting dynamic subtest: pipe-A-eDP-1 [403.541395] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.873s) [403.556934] Starting dynamic subtest: pipe-D-eDP-1 [406.095871] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s) [406.098192] Subtest query-busy: SUCCESS (4.428s) [406.926046] [095/133] (613s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [407.030489] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [407.036096] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [407.150436] [096/133] (613s left) kms_addfb_basic (invalid-get-prop-any) [407.206202] Starting subtest: invalid-get-prop-any [407.208544] Subtest invalid-get-prop-any: SUCCESS (0.000s) [407.376509] [097/133] (613s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [407.480230] Starting subtest: fbc-psr2-cursor-mmap-gtt [407.482790] Starting dynamic subtest: eDP-1 [407.487854] Dynamic subtest eDP-1: SKIP (0.000s) [407.492648] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.002s) [407.579045] [098/133] (613s left) kms_flip (2x-blocking-absolute-wf_vblank) [407.672505] Starting subtest: 2x-blocking-absolute-wf_vblank [407.684113] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s) [407.791857] [099/133] (613s left) kms_cursor_crc (cursor-onscreen-256x85) [408.050134] Starting subtest: cursor-onscreen-256x85 [408.127002] Subtest cursor-onscreen-256x85: SKIP (0.070s) [408.318979] [100/133] (612s left) kms_flip (2x-modeset-vs-vblank-race) [408.413295] Starting subtest: 2x-modeset-vs-vblank-race [408.422917] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s) [408.564602] [101/133] (612s left) kms_atomic_interruptible (atomic-setmode) [408.664961] Starting subtest: atomic-setmode [408.667008] Starting dynamic subtest: pipe-A-eDP-1 [415.555617] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.890s) [415.558494] Subtest atomic-setmode: SUCCESS (6.891s) [416.444922] [102/133] (604s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render) [416.562389] Starting subtest: psr-argb161616f-draw-render [416.566952] Subtest psr-argb161616f-draw-render: SKIP (0.000s) [416.697150] [103/133] (604s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [416.794338] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [416.799209] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [416.935649] [104/133] (604s left) kms_plane_scaling (invalid-num-scalers) [417.036335] Starting subtest: invalid-num-scalers [417.038906] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [417.055077] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s) [417.066034] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [417.088085] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.033s) [417.098145] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [417.123094] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s) [417.138001] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [417.154426] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s) [417.157148] Subtest invalid-num-scalers: SUCCESS (0.120s) [417.296008] [105/133] (603s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [417.397270] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [417.401458] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [417.536511] [106/133] (603s left) sw_sync (alloc_fence_invalid_timeline) [417.577706] Starting subtest: alloc_fence_invalid_timeline [417.580537] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [417.655943] [107/133] (603s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [417.715540] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [417.820605] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s) [417.924228] [108/133] (603s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [418.021051] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [418.023736] Starting dynamic subtest: A-eDP1 [426.963976] Dynamic subtest A-eDP1: SUCCESS (8.942s) [426.979280] Starting dynamic subtest: B-eDP1 [435.902865] Dynamic subtest B-eDP1: SUCCESS (8.937s) [435.913965] Starting dynamic subtest: C-eDP1 [444.815969] Dynamic subtest C-eDP1: SUCCESS (8.910s) [444.828857] Starting dynamic subtest: D-eDP1 [453.737604] Dynamic subtest D-eDP1: SUCCESS (8.919s) [453.740544] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.716s) [454.999970] [109/133] (566s left) kms_addfb_basic (size-max) [455.098510] Starting subtest: size-max [455.100888] Subtest size-max: SUCCESS (0.000s) [455.218086] [110/133] (566s left) kms_cursor_crc (cursor-rapid-movement-256x256) [455.448279] Starting subtest: cursor-rapid-movement-256x256 [455.451327] Starting dynamic subtest: pipe-A-eDP-1 [455.985887] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.534s) [456.018609] Starting dynamic subtest: pipe-D-eDP-1 [457.185148] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.174s) [457.187297] Subtest cursor-rapid-movement-256x256: SUCCESS (1.735s) [458.069240] [111/133] (563s left) gem_exec_whisper (basic-queues-all) [458.136444] Starting subtest: basic-queues-all [465.799454] Subtest basic-queues-all: SUCCESS (7.658s) [466.012113] [112/133] (555s left) kms_dsc (dsc-fractional-bpp) [466.111461] Starting subtest: dsc-fractional-bpp [466.127238] Subtest dsc-fractional-bpp: SKIP (0.001s) [466.208028] [113/133] (555s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [466.314661] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [466.317480] Starting dynamic subtest: pipe-A-default-mode [466.609561] Dynamic subtest pipe-A-default-mode: SKIP (0.290s) [466.615438] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.292s) [467.496659] [114/133] (554s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [467.606123] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [467.611395] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [467.745988] [115/133] (553s left) gem_softpin (evict-prime) [467.805333] Starting subtest: evict-prime [467.808103] Starting dynamic subtest: rcs0 [469.001367] Dynamic subtest rcs0: SUCCESS (1.196s) [469.012930] Starting dynamic subtest: bcs0 [470.153323] Dynamic subtest bcs0: SUCCESS (1.149s) [470.166290] Starting dynamic subtest: vcs0 [472.150641] Dynamic subtest vcs0: SUCCESS (1.994s) [472.163641] Starting dynamic subtest: vcs1 [474.056374] Dynamic subtest vcs1: SUCCESS (1.903s) [474.069729] Starting dynamic subtest: vecs0 [476.124496] Dynamic subtest vecs0: SUCCESS (2.065s) [476.138335] Starting dynamic subtest: ccs0 [477.279262] Dynamic subtest ccs0: SUCCESS (1.153s) [477.292473] Starting dynamic subtest: all [479.115066] Dynamic subtest all: SUCCESS (1.833s) [479.118013] Subtest evict-prime: SUCCESS (11.309s) [479.225265] [116/133] (542s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [479.333147] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [479.338405] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [479.451907] [117/133] (542s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [479.553840] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [479.676964] [118/133] (542s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [479.734911] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [479.835320] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.101s) [479.940075] [119/133] (541s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [480.039463] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [480.044740] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [480.177095] [120/133] (541s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [480.283987] Starting subtest: fbc-1p-primscrn-cur-indfb-move [484.379066] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.097s) [485.590099] [121/133] (536s left) gem_mmap_wc (bad-size) [485.654606] Subtest bad-size: SKIP (0.000s) [485.708921] [122/133] (536s left) kms_hdr (static-toggle-suspend) [485.820435] Starting subtest: static-toggle-suspend [485.829414] Subtest static-toggle-suspend: SKIP (0.000s) [485.921142] [123/133] (536s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [486.020626] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [486.025664] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [486.155842] [124/133] (535s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [491.250241] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [491.252326] Starting dynamic subtest: pipe-A-eDP-1 [492.030174] Dynamic subtest pipe-A-eDP-1: SKIP (0.775s) [492.041403] Starting dynamic subtest: pipe-B-eDP-1 [493.165085] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s) [493.170354] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.913s) [494.384001] [125/133] (527s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [494.497433] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [494.502472] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [494.634438] [126/133] (527s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [494.729634] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [494.732389] Starting dynamic subtest: pipe-A-eDP-1 [494.756773] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [494.769473] Starting dynamic subtest: pipe-B-eDP-1 [494.792782] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [494.803456] Starting dynamic subtest: pipe-C-eDP-1 [494.827480] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [494.838456] Starting dynamic subtest: pipe-D-eDP-1 [494.863752] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [494.866588] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.010s) [497.036012] [127/133] (525s left) syncobj_timeline (single-wait-all-available-submitted) [497.094610] Starting subtest: single-wait-all-available-submitted [497.097402] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [497.207952] [128/133] (525s left) gem_exec_parallel (userptr) [497.265538] Starting subtest: userptr [497.268049] Starting dynamic subtest: rcs0 [498.985958] Dynamic subtest rcs0: SUCCESS (1.719s) [498.996841] Starting dynamic subtest: bcs0 [500.671449] Dynamic subtest bcs0: SUCCESS (1.684s) [500.682328] Starting dynamic subtest: vcs0 [504.121094] Dynamic subtest vcs0: SUCCESS (3.446s) [504.132457] Starting dynamic subtest: vcs1 [506.121433] Dynamic subtest vcs1: SUCCESS (1.997s) [506.132911] Starting dynamic subtest: vecs0 [508.113913] Dynamic subtest vecs0: SUCCESS (1.989s) [508.127634] Starting dynamic subtest: ccs0 [509.931382] Dynamic subtest ccs0: SUCCESS (1.816s) [509.934650] Subtest userptr: SUCCESS (12.664s) [510.147161] [129/133] (512s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [510.258310] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [510.263376] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [510.371238] [130/133] (511s left) i915_selftest (mock) [513.311520] Starting subtest: mock [513.313990] Starting dynamic subtest: sanitycheck [515.346514] Dynamic subtest sanitycheck: SUCCESS (2.034s) [515.356989] Starting dynamic subtest: shmem [517.304957] Dynamic subtest shmem: SUCCESS (1.956s) [517.315713] Starting dynamic subtest: fence [526.325484] Dynamic subtest fence: SUCCESS (9.017s) [526.335530] Starting dynamic subtest: scatterlist [529.271114] Dynamic subtest scatterlist: SUCCESS (2.943s) [529.281444] Starting dynamic subtest: syncmap [533.836122] Dynamic subtest syncmap: SUCCESS (4.562s) [533.847082] Starting dynamic subtest: uncore [535.725053] Dynamic subtest uncore: SUCCESS (1.887s) [535.741193] Starting dynamic subtest: ring [537.714819] Dynamic subtest ring: SUCCESS (1.988s) [537.730978] Starting dynamic subtest: engine [539.732310] Dynamic subtest engine: SUCCESS (2.015s) [539.743120] Starting dynamic subtest: timelines [545.076248] Dynamic subtest timelines: SUCCESS (5.341s) [545.086479] Starting dynamic subtest: requests [550.001246] Dynamic subtest requests: SUCCESS (4.922s) [550.011855] Starting dynamic subtest: objects [552.179296] Dynamic subtest objects: SUCCESS (2.175s) [552.189500] Starting dynamic subtest: phys [554.347993] Dynamic subtest phys: SUCCESS (2.166s) [554.358601] Starting dynamic subtest: dmabuf [556.476645] Dynamic subtest dmabuf: SUCCESS (2.126s) [556.486586] Starting dynamic subtest: vma [563.315269] Dynamic subtest vma: SUCCESS (6.835s) [563.326176] Starting dynamic subtest: evict [566.078066] Dynamic subtest evict: SUCCESS (2.760s) [566.088600] Starting dynamic subtest: gtt [570.676022] Dynamic subtest gtt: SUCCESS (4.592s) [570.686115] Starting dynamic subtest: hugepages [573.016091] Dynamic subtest hugepages: SUCCESS (2.338s) [573.026428] Starting dynamic subtest: memory_region [577.035213] Dynamic subtest memory_region: SUCCESS (4.020s) [577.037859] Subtest mock: SUCCESS (63.710s) [577.066988] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [577.067725] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [577.071396] [131/133] (445s left) gem_mmap_gtt (basic-write-read) [579.946372] Subtest basic-write-read: SKIP (0.000s) [580.009809] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [580.011089] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true [580.015080] [132/133] (442s left) perf (gen12-group-exclusive-stream-sample-oa) [580.163015] Starting subtest: gen12-group-exclusive-stream-sample-oa [580.185388] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.023s) [580.229950] [133/133] (442s left) perf_pmu (busy-double-start) [580.269599] Starting subtest: busy-double-start [580.272516] Starting dynamic subtest: rcs0 [583.935541] Dynamic subtest rcs0: FAIL (3.594s) [583.945435] Starting dynamic subtest: bcs0 [587.469624] Dynamic subtest bcs0: SUCCESS (3.606s) [587.480655] Starting dynamic subtest: vcs0 [591.653547] Dynamic subtest vcs0: SUCCESS (4.183s) [591.665157] Starting dynamic subtest: vcs1 [595.686973] Dynamic subtest vcs1: SUCCESS (4.031s) [595.699651] Starting dynamic subtest: vecs0 [599.637991] Dynamic subtest vecs0: SUCCESS (3.949s) [599.650444] Starting dynamic subtest: ccs0 [603.290657] Dynamic subtest ccs0: FAIL (3.567s) [603.293162] Subtest busy-double-start: FAIL (22.941s) [603.349050] 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.