[38.348755] Initializing watchdogs [38.348839] /dev/watchdog0 [38.357267] [001/129] (960s left) syncobj_eventfd (binary-wait-signaled) [38.414133] Starting subtest: binary-wait-signaled [38.416519] Subtest binary-wait-signaled: SUCCESS (0.000s) [38.484096] [002/129] (960s left) syncobj_wait (invalid-signal-bad-pad) [38.532678] Starting subtest: invalid-signal-bad-pad [38.535179] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [38.583866] [003/129] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [38.681613] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [38.686106] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [38.765490] [004/129] (960s left) gem_exec_reloc (basic-write-wc-noreloc) [38.816908] Subtest basic-write-wc-noreloc: SKIP (0.000s) [38.854844] [005/129] (960s left) gem_exec_schedule (noreorder-priority) [39.024332] Starting subtest: noreorder-priority [39.026323] Starting dynamic subtest: rcs0 [40.182364] Dynamic subtest rcs0: SUCCESS (1.158s) [40.191693] Starting dynamic subtest: vcs0 [41.401622] Dynamic subtest vcs0: SUCCESS (1.218s) [41.408053] Starting dynamic subtest: vcs1 [43.388481] Dynamic subtest vcs1: SUCCESS (1.987s) [43.395671] Starting dynamic subtest: vecs0 [45.349408] Dynamic subtest vecs0: SUCCESS (1.961s) [45.356801] Starting dynamic subtest: ccs0 [46.509663] Dynamic subtest ccs0: SUCCESS (1.162s) [46.512146] Subtest noreorder-priority: SUCCESS (7.486s) [46.676524] [006/129] (952s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [46.785931] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [51.672362] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (4.890s) [51.758704] [007/129] (947s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [51.837945] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [51.840429] Starting dynamic subtest: pipe-A-default-mode [54.656679] Dynamic subtest pipe-A-default-mode: SUCCESS (2.815s) [54.658727] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.816s) [55.558563] [008/129] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [55.659368] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [55.663668] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [55.727326] [009/129] (943s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [55.782943] Starting subtest: etime-multi-wait-available-unsubmitted [55.885402] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.102s) [55.939248] [010/129] (943s left) gem_userptr_blits (usage-restrictions) [55.992757] Starting subtest: usage-restrictions [55.995050] Subtest usage-restrictions: SUCCESS (0.000s) [56.109578] [011/129] (942s left) perf_pmu (rc6-suspend) [56.140442] Starting subtest: rc6-suspend [78.784840] Subtest rc6-suspend: SUCCESS (7.416s) [79.650438] [012/129] (934s left) i915_suspend (sysfs-reader) [79.702489] Starting subtest: sysfs-reader [97.579338] Subtest sysfs-reader: SUCCESS (3.025s) [97.596634] [013/129] (931s left) gem_tiled_fence_blits (basic) [97.653259] Subtest basic: SKIP (0.000s) [97.706856] [014/129] (931s left) kms_draw_crc (draw-method-mmap-wc) [97.791258] Starting subtest: draw-method-mmap-wc [97.793208] Starting dynamic subtest: xrgb8888-untiled [97.990584] Dynamic subtest xrgb8888-untiled: SUCCESS (0.199s) [97.998054] Starting dynamic subtest: rgb565-untiled [98.180160] Dynamic subtest rgb565-untiled: SUCCESS (0.189s) [98.187317] Starting dynamic subtest: xrgb2101010-untiled [98.357484] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.178s) [98.365952] Starting dynamic subtest: xrgb8888-xtiled [98.457903] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.100s) [98.463334] Starting dynamic subtest: rgb565-xtiled [98.558003] Dynamic subtest rgb565-xtiled: SUCCESS (0.100s) [98.563754] Starting dynamic subtest: xrgb2101010-xtiled [98.657696] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.100s) [98.664794] Starting dynamic subtest: xrgb8888-4tiled [98.780439] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s) [98.787150] Starting dynamic subtest: rgb565-4tiled [98.890597] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s) [98.896339] Starting dynamic subtest: xrgb2101010-4tiled [99.002123] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s) [99.004107] Subtest draw-method-mmap-wc: SUCCESS (1.211s) [99.083690] [015/129] (930s left) gem_exec_schedule (thriceslice) [99.148535] Starting subtest: thriceslice [99.150228] Starting dynamic subtest: rcs0 [99.190088] Dynamic subtest rcs0: SUCCESS (0.051s) [99.199455] Starting dynamic subtest: bcs0 [99.220503] Dynamic subtest bcs0: SUCCESS (0.031s) [99.226577] Starting dynamic subtest: vcs0 [99.249123] Dynamic subtest vcs0: SUCCESS (0.028s) [99.255872] Starting dynamic subtest: vcs1 [99.299158] Dynamic subtest vcs1: SUCCESS (0.049s) [99.306973] Starting dynamic subtest: vecs0 [99.329658] Dynamic subtest vecs0: SUCCESS (0.031s) [99.337187] Starting dynamic subtest: ccs0 [99.356716] Dynamic subtest ccs0: SUCCESS (0.027s) [99.359030] Subtest thriceslice: SUCCESS (0.218s) [100.472531] [016/129] (928s left) perf (gen12-oa-tlb-invalidate) [100.610737] Starting subtest: gen12-oa-tlb-invalidate [100.612713] Starting dynamic subtest: 0-rcs0 [110.645805] Dynamic subtest 0-rcs0: SUCCESS (10.033s) [110.652225] Starting dynamic subtest: 1-vecs0 [120.695593] Dynamic subtest 1-vecs0: SUCCESS (10.050s) [120.698538] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.083s) [120.715038] [017/129] (908s left) kms_cursor_edge_walk (64x64-right-edge) [120.805259] Starting subtest: 64x64-right-edge [120.807749] Starting dynamic subtest: pipe-A-eDP-1 [124.332423] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.525s) [124.339823] Starting dynamic subtest: pipe-D-eDP-1 [127.528005] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.196s) [127.530501] Subtest 64x64-right-edge: SUCCESS (6.722s) [128.391610] [018/129] (900s left) kms_addfb_basic (too-high) [128.478904] Starting subtest: too-high [128.481365] Subtest too-high: SUCCESS (0.000s) [128.547154] [019/129] (900s left) gem_media_vme [128.634296] [020/129] (900s left) kms_big_fb (4-tiled-64bpp-rotate-180) [128.725937] Starting subtest: 4-tiled-64bpp-rotate-180 [130.104465] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.379s) [130.235475] [021/129] (898s left) kms_psr (psr-primary-mmap-gtt) [130.325962] Starting subtest: psr-primary-mmap-gtt [130.328392] Starting dynamic subtest: eDP-1 [131.794889] Dynamic subtest eDP-1: SKIP (1.463s) [131.800015] Subtest psr-primary-mmap-gtt: SKIP (1.463s) [131.927126] [022/129] (897s left) gem_exec_balancer (parallel-out-fence) [132.143828] Starting subtest: parallel-out-fence [132.866022] Subtest parallel-out-fence: SUCCESS (0.722s) [132.936323] [023/129] (896s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [138.058288] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf [138.062870] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s) [138.951275] [024/129] (890s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [139.064500] Starting subtest: short-flip-after-cursor-toggle [139.979908] Subtest short-flip-after-cursor-toggle: SUCCESS (0.914s) [140.868103] [025/129] (888s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [140.953441] Starting subtest: invalidate-primary-flip-overlay [151.531870] Subtest invalidate-primary-flip-overlay: SUCCESS (10.577s) [151.634522] [026/129] (877s left) core_hotunplug (unbind-rebind) [151.709289] Starting subtest: unbind-rebind [155.943753] Subtest unbind-rebind: SUCCESS (4.233s) [155.960196] [027/129] (873s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [157.437536] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [157.442429] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [157.509761] [028/129] (871s left) kms_vblank (wait-busy-hang) [157.605797] Starting subtest: wait-busy-hang [157.608132] Starting dynamic subtest: pipe-A-eDP-1 [184.215303] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.604s) [184.228499] Starting dynamic subtest: pipe-D-eDP-1 [199.195205] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.978s) [199.197860] Subtest wait-busy-hang: SUCCESS (41.586s) [200.073217] [029/129] (829s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [200.169941] Starting subtest: psr-rgb565-draw-mmap-gtt [200.173942] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [200.242888] [030/129] (829s left) api_intel_allocator (two-level-inception-interruptible) [200.290255] Starting subtest: two-level-inception-interruptible [205.678843] Subtest two-level-inception-interruptible: SUCCESS (5.391s) [205.759360] [031/129] (823s left) kms_atomic (plane-immutable-zpos) [205.851076] Starting subtest: plane-immutable-zpos [205.853455] Starting dynamic subtest: pipe-A-eDP-1 [206.450461] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s) [206.452876] Subtest plane-immutable-zpos: SUCCESS (0.597s) [207.393654] [032/129] (822s left) fbdev (unaligned-write) [207.431407] Starting subtest: unaligned-write [207.521803] Subtest unaligned-write: SUCCESS (0.090s) [207.561625] [033/129] (821s left) i915_module_load (resize-bar) [207.590229] Starting subtest: resize-bar [207.597120] Subtest resize-bar: SKIP (0.003s) [207.614221] [034/129] (821s left) gem_render_copy (linear-to-vebox-yf-tiled) [207.656021] Starting subtest: linear-to-vebox-yf-tiled [207.660497] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [207.813020] [035/129] (821s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [207.915686] Starting subtest: yf-tiled-64bpp-rotate-180 [207.920228] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [208.004933] [036/129] (821s left) kms_joiner (invalid-modeset-force-ultra-joiner) [208.097214] Starting subtest: invalid-modeset-force-ultra-joiner [208.101175] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [208.138640] [037/129] (821s left) perf (polling-parameterized) [208.222290] Starting subtest: polling-parameterized [228.239085] Subtest polling-parameterized: SUCCESS (20.016s) [228.265237] [038/129] (801s left) kms_lease (simple-lease) [228.348929] Starting subtest: simple-lease [228.351301] Starting dynamic subtest: pipe-A-eDP-1 [228.838835] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.488s) [228.845260] Starting dynamic subtest: pipe-B-eDP-1 [230.304987] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.464s) [230.312098] Starting dynamic subtest: pipe-C-eDP-1 [231.780984] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.474s) [231.789605] Starting dynamic subtest: pipe-D-eDP-1 [233.246787] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.465s) [233.249506] Subtest simple-lease: SUCCESS (4.896s) [234.122873] [039/129] (795s left) gem_exec_fair (basic-pace-share) [234.189640] Subtest basic-pace-share: SKIP (0.000s) [234.216238] [040/129] (795s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [234.309598] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [234.313728] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [234.379041] [041/129] (795s left) prime_self_import (basic-with_one_bo_two_files) [234.406209] Starting subtest: basic-with_one_bo_two_files [234.432205] Subtest basic-with_one_bo_two_files: SUCCESS (0.026s) [234.496974] [042/129] (795s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling) [234.579859] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling [234.582279] Starting dynamic subtest: pipe-A-default-mode [234.868325] Dynamic subtest pipe-A-default-mode: SKIP (0.281s) [234.873181] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.282s) [235.784081] [043/129] (793s left) gem_exec_balancer (bonded-sync) [235.831015] Starting subtest: bonded-sync [235.836125] Subtest bonded-sync: SKIP (0.000s) [236.061002] [044/129] (793s left) kms_sysfs_edid_timing [236.446641] [045/129] (793s left) kms_cursor_legacy (cursor-vs-flip-legacy) [236.567437] Starting subtest: cursor-vs-flip-legacy [265.162173] Subtest cursor-vs-flip-legacy: SUCCESS (28.593s) [266.055471] [046/129] (763s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc) [266.153539] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc [268.763981] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (2.616s) [268.853560] [047/129] (760s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [268.943428] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [269.455525] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.514s) [269.579003] [048/129] (760s left) kms_psr (fbc-pr-cursor-render) [269.663901] Starting subtest: fbc-pr-cursor-render [269.668418] Subtest fbc-pr-cursor-render: SKIP (0.000s) [269.712998] [049/129] (759s left) perf (buffer-fill) [269.788497] Starting subtest: buffer-fill [269.790914] Starting dynamic subtest: 0-rcs0 [271.890624] Dynamic subtest 0-rcs0: SUCCESS (2.101s) [271.898635] Starting dynamic subtest: 1-vcs1 [276.048284] Dynamic subtest 1-vcs1: SUCCESS (4.157s) [276.050906] Subtest buffer-fill: SUCCESS (6.258s) [276.065167] [050/129] (753s left) kms_flip (basic-plain-flip) [276.159146] Starting subtest: basic-plain-flip [276.161481] Starting dynamic subtest: A-eDP1 [277.883230] Dynamic subtest A-eDP1: SUCCESS (1.723s) [277.890614] Starting dynamic subtest: B-eDP1 [279.608398] Dynamic subtest B-eDP1: SUCCESS (1.723s) [279.617293] Starting dynamic subtest: C-eDP1 [281.322779] Dynamic subtest C-eDP1: SUCCESS (1.714s) [281.333038] Starting dynamic subtest: D-eDP1 [283.052141] Dynamic subtest D-eDP1: SUCCESS (1.729s) [283.057775] Subtest basic-plain-flip: SUCCESS (6.899s) [284.293372] [051/129] (745s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [284.390783] Starting subtest: fbcpsr-stridechange [288.466610] Subtest fbcpsr-stridechange: SUCCESS (4.078s) [288.579930] [052/129] (741s left) kms_flip (2x-flip-vs-panning-vs-hang) [288.684113] Starting subtest: 2x-flip-vs-panning-vs-hang [288.697581] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.013s) [288.752403] [053/129] (740s left) gem_fenced_exec_thrash (2-spare-fences) [288.804257] Subtest 2-spare-fences: SKIP (0.000s) [288.844809] [054/129] (740s left) kms_psr (pr-primary-mmap-gtt) [288.934026] Starting subtest: pr-primary-mmap-gtt [288.938587] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [288.984463] [055/129] (740s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [289.086681] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [293.950893] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (4.867s) [294.038284] [056/129] (735s left) kms_vblank (query-idle) [294.129828] Starting subtest: query-idle [294.132145] Starting dynamic subtest: pipe-A-eDP-1 [295.861839] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.730s) [295.876076] Starting dynamic subtest: pipe-D-eDP-1 [298.401810] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.536s) [298.404020] Subtest query-idle: SUCCESS (4.270s) [299.270778] [057/129] (730s left) gem_flink_basic (bad-open) [299.309919] Starting subtest: bad-open [299.312207] Subtest bad-open: SUCCESS (0.000s) [299.362123] [058/129] (730s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [299.461847] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [299.466379] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [299.531174] [059/129] (730s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [299.628663] Starting subtest: 2x-long-cursor-vs-flip-legacy [299.633848] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [299.717295] [060/129] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [299.805413] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [299.809727] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [299.869592] [061/129] (729s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [299.949089] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [299.951435] Starting dynamic subtest: pipe-A-eDP-1 [301.730257] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.781s) [301.739018] Starting dynamic subtest: pipe-B-eDP-1 [304.634229] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.903s) [304.641376] Starting dynamic subtest: pipe-C-eDP-1 [307.491334] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.856s) [307.500418] Starting dynamic subtest: pipe-D-eDP-1 [310.347771] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.856s) [310.349993] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (10.398s) [311.562447] [062/129] (718s left) kms_chamelium_hpd (vga-hpd-without-ddc) [311.948266] Subtest vga-hpd-without-ddc: SKIP (0.000s) [312.819870] [063/129] (717s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [312.924079] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [317.789416] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.870s) [317.891482] [064/129] (712s left) gem_render_copy (yf-tiled-to-vebox-linear) [317.948212] Starting subtest: yf-tiled-to-vebox-linear [317.952871] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [318.107677] [065/129] (711s left) gem_exec_fence (syncobj-timeline-invalid-wait) [318.620270] Starting subtest: syncobj-timeline-invalid-wait [318.626271] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [320.496897] [066/129] (709s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [320.593262] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [320.597405] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [320.683382] [067/129] (709s left) kms_chamelium_hpd (vga-hpd-fast) [321.055076] Subtest vga-hpd-fast: SKIP (0.000s) [321.908491] [068/129] (708s left) syncobj_timeline (single-wait-for-submit-available-submitted) [321.960972] Starting subtest: single-wait-for-submit-available-submitted [321.964224] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [322.020986] [069/129] (707s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [322.108901] Starting subtest: primary-y-tiled-reflect-x-180 [322.171759] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s) [322.239524] [070/129] (707s left) kms_cursor_crc (cursor-rapid-movement-512x170) [322.469141] Starting subtest: cursor-rapid-movement-512x170 [322.473492] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [322.594901] [071/129] (707s left) kms_pm_rpm (cursor) [324.608219] Starting subtest: cursor [335.165108] Subtest cursor: SUCCESS (10.556s) [335.481521] [072/129] (694s left) gem_exec_fence (keep-in-fence) [335.646748] Starting subtest: keep-in-fence [335.649611] Starting dynamic subtest: rcs0 [335.706194] Dynamic subtest rcs0: SUCCESS (0.059s) [335.716246] Starting dynamic subtest: bcs0 [335.758348] Dynamic subtest bcs0: SUCCESS (0.051s) [335.768159] Starting dynamic subtest: vcs0 [337.447434] Dynamic subtest vcs0: SUCCESS (1.687s) [337.458176] Starting dynamic subtest: vcs1 [339.427836] Dynamic subtest vcs1: SUCCESS (1.980s) [339.436347] Starting dynamic subtest: vecs0 [341.478339] Dynamic subtest vecs0: SUCCESS (2.048s) [341.496639] Starting dynamic subtest: ccs0 [341.688215] Dynamic subtest ccs0: SUCCESS (0.210s) [341.691225] Subtest keep-in-fence: SUCCESS (6.041s) [343.504882] [073/129] (686s left) i915_selftest (mock) [346.238910] Starting subtest: mock [346.241502] Starting dynamic subtest: sanitycheck [346.504471] Dynamic subtest sanitycheck: SUCCESS (0.266s) [346.512581] Starting dynamic subtest: shmem [346.752646] Dynamic subtest shmem: SUCCESS (0.247s) [346.760615] Starting dynamic subtest: fence [353.588601] Dynamic subtest fence: SUCCESS (6.833s) [353.598853] Starting dynamic subtest: scatterlist [354.849564] Dynamic subtest scatterlist: SUCCESS (1.260s) [354.857516] Starting dynamic subtest: syncmap [357.693350] Dynamic subtest syncmap: SUCCESS (2.843s) [357.701558] Starting dynamic subtest: uncore [357.937961] Dynamic subtest uncore: SUCCESS (0.245s) [357.945913] Starting dynamic subtest: ring [358.179366] Dynamic subtest ring: SUCCESS (0.240s) [358.187464] Starting dynamic subtest: engine [358.420553] Dynamic subtest engine: SUCCESS (0.240s) [358.428760] Starting dynamic subtest: timelines [361.450248] Dynamic subtest timelines: SUCCESS (3.028s) [361.457994] Starting dynamic subtest: requests [364.631467] Dynamic subtest requests: SUCCESS (3.179s) [364.639573] Starting dynamic subtest: objects [364.957544] Dynamic subtest objects: SUCCESS (0.326s) [364.965283] Starting dynamic subtest: phys [365.293276] Dynamic subtest phys: SUCCESS (0.335s) [365.300554] Starting dynamic subtest: dmabuf [365.637537] Dynamic subtest dmabuf: SUCCESS (0.344s) [365.644846] Starting dynamic subtest: vma [370.466804] Dynamic subtest vma: SUCCESS (4.827s) [370.473888] Starting dynamic subtest: evict [371.297611] Dynamic subtest evict: SUCCESS (0.830s) [371.305328] Starting dynamic subtest: gtt [374.097280] Dynamic subtest gtt: SUCCESS (2.799s) [374.105093] Starting dynamic subtest: hugepages [374.513187] Dynamic subtest hugepages: SUCCESS (0.415s) [374.519332] Starting dynamic subtest: memory_region [377.350432] Dynamic subtest memory_region: SUCCESS (2.836s) [377.353563] Subtest mock: SUCCESS (31.109s) [377.368553] [074/129] (652s left) kms_plane (plane-panning-bottom-right-suspend) [378.972174] Starting subtest: plane-panning-bottom-right-suspend [378.974576] Starting dynamic subtest: pipe-A [396.958040] Dynamic subtest pipe-A: SUCCESS (3.551s) [396.966314] Starting dynamic subtest: pipe-B [415.888980] Dynamic subtest pipe-B: SUCCESS (3.457s) [415.891080] Subtest plane-panning-bottom-right-suspend: SUCCESS (7.009s) [416.808195] [075/129] (643s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [416.909502] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [416.914249] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [416.982680] [076/129] (643s left) gem_exec_params (secure-non-master) [417.022749] Starting subtest: secure-non-master [417.026904] Subtest secure-non-master: SKIP (0.000s) [417.080176] [077/129] (642s left) gem_ctx_create (basic-files) [417.126016] Starting subtest: basic-files [419.133029] Subtest basic-files: SUCCESS (2.004s) [420.436457] [078/129] (639s left) gem_mmap_gtt (hang-user) [420.483268] Subtest hang-user: SKIP (0.000s) [420.523081] [079/129] (639s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [420.622240] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [420.626871] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [420.694722] [080/129] (639s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [420.792081] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [420.796557] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [420.858554] [081/129] (639s left) kms_psr (fbc-psr2-sprite-blt) [420.947726] Starting subtest: fbc-psr2-sprite-blt [420.949951] Starting dynamic subtest: eDP-1 [420.953892] Dynamic subtest eDP-1: SKIP (0.000s) [420.957867] Subtest fbc-psr2-sprite-blt: SKIP (0.001s) [421.000527] [082/129] (639s left) syncobj_wait (invalid-signal-zero-handles) [421.051636] Starting subtest: invalid-signal-zero-handles [421.053970] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [421.121397] [083/129] (638s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [421.216047] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [421.218750] Starting dynamic subtest: pipe-A-eDP-1 [421.245626] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [421.257003] Starting dynamic subtest: pipe-B-eDP-1 [421.278306] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [421.284718] Starting dynamic subtest: pipe-C-eDP-1 [421.305406] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [421.311451] Starting dynamic subtest: pipe-D-eDP-1 [421.333826] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [421.338358] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.004s) [421.352681] [084/129] (638s left) kms_psr (pr-cursor-mmap-cpu) [421.442484] Starting subtest: pr-cursor-mmap-cpu [421.446054] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [421.495472] [085/129] (638s left) kms_pwrite_crc [423.063720] [086/129] (637s left) kms_cursor_crc (cursor-onscreen-128x128) [423.227983] Starting subtest: cursor-onscreen-128x128 [423.230245] Starting dynamic subtest: pipe-A-eDP-1 [425.307463] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.072s) [425.328133] Starting dynamic subtest: pipe-D-eDP-1 [428.152601] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.826s) [428.155506] Subtest cursor-onscreen-128x128: SUCCESS (4.919s) [429.008630] [087/129] (631s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [429.061666] Starting subtest: legacy-engines-hostile-preempt [429.064165] Starting dynamic subtest: render [429.131731] Dynamic subtest render: SUCCESS (0.070s) [429.141699] Starting dynamic subtest: bsd1 [430.311209] Dynamic subtest bsd1: SUCCESS (1.176s) [430.321068] Starting dynamic subtest: bsd2 [432.355465] Dynamic subtest bsd2: SUCCESS (2.042s) [432.364944] Starting dynamic subtest: blt [432.419670] Dynamic subtest blt: SUCCESS (0.064s) [432.425813] Starting dynamic subtest: vebox [434.363969] Dynamic subtest vebox: SUCCESS (1.941s) [434.367264] Subtest legacy-engines-hostile-preempt: SUCCESS (5.300s) [434.421531] [088/129] (625s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [434.519777] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [434.522164] Starting dynamic subtest: pipe-A-eDP-1 [434.544945] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [434.551700] Starting dynamic subtest: pipe-B-eDP-1 [434.573560] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [434.580794] Starting dynamic subtest: pipe-C-eDP-1 [434.601989] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [434.608694] Starting dynamic subtest: pipe-D-eDP-1 [434.630771] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [434.635204] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.003s) [434.649046] [089/129] (625s left) gem_workarounds (basic-read-context) [434.700488] Starting subtest: basic-read-context [434.711809] Subtest basic-read-context: SUCCESS (0.010s) [434.816305] [090/129] (625s left) gem_softpin (safe-alignment) [434.868219] Starting subtest: safe-alignment [434.887710] Subtest safe-alignment: SUCCESS (0.020s) [436.357046] [091/129] (623s left) kms_invalid_mode (int-max-clock) [436.447425] Starting subtest: int-max-clock [436.450281] Starting dynamic subtest: pipe-A-eDP-1 [436.727854] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s) [436.735989] Starting dynamic subtest: pipe-B-eDP-1 [436.737966] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [436.744219] Starting dynamic subtest: pipe-C-eDP-1 [436.746412] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [436.752974] Starting dynamic subtest: pipe-D-eDP-1 [436.755336] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [436.757739] Subtest int-max-clock: SUCCESS (0.285s) [437.592902] [092/129] (622s left) fbdev (eof) [437.624222] Starting subtest: eof [437.626812] Subtest eof: SUCCESS (0.000s) [437.657114] [093/129] (622s left) gem_create (create-size-update) [437.692998] Starting subtest: create-size-update [437.695261] Subtest create-size-update: SUCCESS (0.000s) [437.892201] [094/129] (622s left) kms_big_fb (linear-32bpp-rotate-90) [437.997852] Starting subtest: linear-32bpp-rotate-90 [438.015760] Subtest linear-32bpp-rotate-90: SKIP (0.018s) [438.104381] [095/129] (622s left) kms_plane_scaling (planes-upscale-20x20) [438.176819] Starting subtest: planes-upscale-20x20 [438.179336] Starting dynamic subtest: pipe-A [438.241522] Dynamic subtest pipe-A: SUCCESS (0.065s) [438.250658] Starting dynamic subtest: pipe-B [439.468476] Dynamic subtest pipe-B: SUCCESS (1.225s) [439.477867] Starting dynamic subtest: pipe-C [440.661397] Dynamic subtest pipe-C: SUCCESS (1.192s) [440.668384] Starting dynamic subtest: pipe-D [441.810732] Dynamic subtest pipe-D: SUCCESS (1.148s) [441.813178] Subtest planes-upscale-20x20: SUCCESS (3.633s) [443.033703] [096/129] (617s left) syncobj_timeline (multi-wait-for-submit-signaled) [443.081585] Starting subtest: multi-wait-for-submit-signaled [443.083682] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [443.143438] [097/129] (617s left) kms_cursor_crc (cursor-random-64x21) [443.300576] Starting subtest: cursor-random-64x21 [443.333309] Subtest cursor-random-64x21: SKIP (0.028s) [443.514283] [098/129] (616s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [443.610543] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [443.614997] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [443.692418] [099/129] (616s left) gem_caching (read-writes) [443.752512] Subtest read-writes: SKIP (0.000s) [443.798997] [100/129] (616s left) gem_eio (wait-wedge-10ms) [444.015422] Starting subtest: wait-wedge-10ms [445.440409] Subtest wait-wedge-10ms: SUCCESS (1.425s) [445.562951] [101/129] (614s left) gem_ctx_param (root-set) [445.610228] Starting subtest: root-set [445.613105] Subtest root-set: SUCCESS (0.001s) [445.688072] [102/129] (614s left) i915_pm_rpm (debugfs-read) [447.492290] Starting subtest: debugfs-read [448.654628] Subtest debugfs-read: SUCCESS (1.159s) [448.993516] [103/129] (611s left) kms_rotation_crc (bad-pixel-format) [449.080836] Starting subtest: bad-pixel-format [449.085589] Subtest bad-pixel-format: SKIP (0.001s) [449.132136] [104/129] (611s left) kms_pm_rpm (modeset-pc8-residency-stress) [450.638418] Starting subtest: modeset-pc8-residency-stress [450.644225] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [451.413654] [105/129] (609s left) kms_plane_scaling (plane-downscale-factor-0-25-with-pixel-format) [451.497844] Starting subtest: plane-downscale-factor-0-25-with-pixel-format [451.500283] Starting dynamic subtest: pipe-A [451.514469] Dynamic subtest pipe-A: SKIP (0.010s) [451.526755] Starting dynamic subtest: pipe-B [451.537753] Dynamic subtest pipe-B: SKIP (0.018s) [451.548502] Starting dynamic subtest: pipe-C [451.558315] Dynamic subtest pipe-C: SKIP (0.018s) [451.568516] Starting dynamic subtest: pipe-D [451.576803] Dynamic subtest pipe-D: SKIP (0.020s) [451.581061] Subtest plane-downscale-factor-0-25-with-pixel-format: SKIP (0.067s) [451.640451] [106/129] (608s left) kms_properties (invalid-properties-legacy) [451.723763] Starting subtest: invalid-properties-legacy [451.861643] Subtest invalid-properties-legacy: SUCCESS (0.136s) [451.914827] [107/129] (608s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [452.022317] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [452.026614] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [452.105827] [108/129] (608s left) kms_chamelium_frames (dp-crc-fast) [452.474349] Subtest dp-crc-fast: SKIP (0.000s) [453.315865] [109/129] (607s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs) [453.400553] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs [453.402879] Starting dynamic subtest: pipe-A-eDP-1 [453.427599] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [453.436335] Starting dynamic subtest: pipe-B-eDP-1 [453.460869] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [453.468590] Starting dynamic subtest: pipe-C-eDP-1 [453.493161] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [453.500609] Starting dynamic subtest: pipe-D-eDP-1 [453.525743] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [453.529963] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s) [453.544723] [110/129] (606s left) drm_fdinfo (isolation) [453.576651] Starting subtest: isolation [453.578799] Starting dynamic subtest: rcs0 [453.592843] Dynamic subtest rcs0: SKIP (0.015s) [453.601996] Starting dynamic subtest: bcs0 [453.606977] Dynamic subtest bcs0: SKIP (0.009s) [453.614092] Starting dynamic subtest: vcs0 [453.618637] Dynamic subtest vcs0: SKIP (0.000s) [453.625200] Starting dynamic subtest: vcs1 [453.629752] Dynamic subtest vcs1: SKIP (0.000s) [453.636628] Starting dynamic subtest: vecs0 [453.642077] Dynamic subtest vecs0: SKIP (0.000s) [453.649323] Starting dynamic subtest: ccs0 [453.654523] Dynamic subtest ccs0: SKIP (0.000s) [453.659040] Subtest isolation: SKIP (0.027s) [453.673101] [111/129] (606s left) syncobj_basic (bad-fd-to-handle) [453.717472] Starting subtest: bad-fd-to-handle [453.719945] Subtest bad-fd-to-handle: SUCCESS (0.000s) [453.781671] [112/129] (606s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf) [458.893401] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf [458.899144] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s) [459.800862] [113/129] (600s left) gem_exec_whisper (basic-normal-all) [459.845528] Starting subtest: basic-normal-all [462.074476] Subtest basic-normal-all: SUCCESS (2.228s) [462.231261] [114/129] (598s left) gem_ctx_param (invalid-get-no-zeromap) [462.277776] Starting subtest: invalid-get-no-zeromap [462.280325] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [462.363926] [115/129] (598s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [462.464498] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [467.300081] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (4.837s) [467.425680] [116/129] (593s left) gem_exec_nop (basic-parallel) [467.497127] Starting subtest: basic-parallel [483.318155] Subtest basic-parallel: SUCCESS (15.833s) [483.512603] [117/129] (577s left) kms_draw_crc (fill-fb) [483.618523] Starting subtest: fill-fb [484.014311] Subtest fill-fb: SUCCESS (0.398s) [484.071465] [118/129] (576s left) gem_eio (wait-immediate) [484.286139] Starting subtest: wait-immediate [484.667208] Subtest wait-immediate: SUCCESS (0.381s) [484.772910] [119/129] (575s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [484.889776] Starting subtest: flip-vs-cursor-crc-atomic [485.502473] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.615s) [486.426371] [120/129] (574s left) gem_exec_whisper (basic-contexts-all) [486.482983] Starting subtest: basic-contexts-all [496.463571] Subtest basic-contexts-all: SUCCESS (9.977s) [496.618990] [121/129] (564s left) gen7_exec_parse (batch-without-end) [496.671645] Subtest batch-without-end: SKIP (0.000s) [496.716096] [122/129] (564s left) gem_mmap (pf-nonblock) [496.769684] Subtest pf-nonblock: SKIP (0.000s) [496.804116] [123/129] (563s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [496.903625] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [496.907629] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [496.963330] [124/129] (563s left) perf (oa-exponents) [497.058670] Starting subtest: oa-exponents [497.060963] Starting dynamic subtest: 0-rcs0 [498.848816] Dynamic subtest 0-rcs0: SUCCESS (1.789s) [498.856023] Starting dynamic subtest: 1-vcs1 [500.680698] Dynamic subtest 1-vcs1: SUCCESS (1.831s) [500.682944] Subtest oa-exponents: SUCCESS (3.621s) [500.713194] [125/129] (560s left) syncobj_timeline (invalid-transfer-illegal-handle) [500.768300] Starting subtest: invalid-transfer-illegal-handle [500.770842] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [500.861512] [126/129] (559s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [500.959389] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [500.963952] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [501.034133] [127/129] (559s left) gem_vm_create (execbuf) [501.091426] Starting subtest: execbuf [501.098023] Subtest execbuf: SUCCESS (0.007s) [501.206560] [128/129] (559s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [501.292071] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [501.296480] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [501.372301] [129/129] (559s left) kms_flip (plain-flip-ts-check) [501.463766] Starting subtest: plain-flip-ts-check [501.465999] Starting dynamic subtest: A-eDP1 [510.430670] Dynamic subtest A-eDP1: SUCCESS (8.963s) [510.439176] Starting dynamic subtest: B-eDP1 [519.399835] Dynamic subtest B-eDP1: SUCCESS (8.969s) [519.409769] Starting dynamic subtest: C-eDP1 [528.347171] Dynamic subtest C-eDP1: SUCCESS (8.947s) [528.354893] Starting dynamic subtest: D-eDP1 [537.243110] Dynamic subtest D-eDP1: SUCCESS (8.895s) [537.245951] Subtest plain-flip-ts-check: SUCCESS (35.785s) [538.454519] Closing watchdogs Done.