[49.345919] Initializing watchdogs [49.345981] /dev/watchdog0 [49.359249] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics] [49.364071] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [49.366692] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [49.368538] [001/131] (960s left) syncobj_wait (wait-all-interrupted) [49.485641] Starting subtest: wait-all-interrupted [49.587968] Subtest wait-all-interrupted: SUCCESS (0.103s) [49.647280] [002/131] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [49.738485] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [49.739885] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [49.835512] [003/131] (960s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [49.925921] Starting subtest: fbc-shrfb-scaledprimary [52.778814] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.881s) [52.913352] [004/131] (957s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [53.020853] Starting subtest: verify-pxp-stale-buf-optout-execution [54.085683] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.073s) [54.201678] [005/131] (955s left) gem_pxp (hw-rejects-pxp-context) [54.240231] Starting subtest: hw-rejects-pxp-context [54.241692] Subtest hw-rejects-pxp-context: SKIP (0.000s) [54.305725] [006/131] (955s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [54.396712] Starting subtest: ccs-on-another-bo-y-tiled-ccs [54.397402] Starting dynamic subtest: pipe-A-HDMI-A-1 [54.404233] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [54.408780] Starting dynamic subtest: pipe-B-HDMI-A-1 [54.415524] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [54.420706] Starting dynamic subtest: pipe-C-HDMI-A-1 [54.427411] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [54.432431] Starting dynamic subtest: pipe-D-HDMI-A-1 [54.439206] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [54.440558] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s) [54.644423] [007/131] (955s left) kms_content_protection (content-type-change) [54.745283] Starting subtest: content-type-change [55.065762] Subtest content-type-change: SKIP (0.320s) [55.227794] [008/131] (954s left) prime_mmap (test_forked) [55.265010] Starting subtest: test_forked [55.265696] Starting dynamic subtest: test_forked-smem [55.277382] Dynamic subtest test_forked-smem: SUCCESS (0.013s) [55.278120] Subtest test_forked: SUCCESS (0.013s) [55.373035] [009/131] (954s left) gem_userptr_blits (probe) [55.432229] Starting subtest: probe [55.553525] Subtest probe: SUCCESS (0.115s) [55.649790] [010/131] (954s left) gem_mmap (basic-small-bo) [55.685323] Starting subtest: basic-small-bo [56.150143] Subtest basic-small-bo: SUCCESS (0.459s) [56.208774] [011/131] (953s left) kms_feature_discovery (display) [56.350827] Starting subtest: display [56.351586] Subtest display: SUCCESS (0.000s) [56.399729] [012/131] (953s left) kms_big_fb (y-tiled-8bpp-rotate-270) [56.498058] Starting subtest: y-tiled-8bpp-rotate-270 [56.572524] Subtest y-tiled-8bpp-rotate-270: SKIP (0.074s) [56.662250] [013/131] (953s left) gem_cs_tlb (engines) [56.704236] Starting subtest: engines [56.704935] Starting dynamic subtest: rcs0 [58.856284] Dynamic subtest rcs0: SUCCESS (2.152s) [58.861897] Starting dynamic subtest: bcs0 [61.027261] Dynamic subtest bcs0: SUCCESS (2.151s) [61.032409] Starting dynamic subtest: vcs0 [63.148519] Dynamic subtest vcs0: SUCCESS (2.153s) [63.153664] Starting dynamic subtest: vcs1 [65.323207] Dynamic subtest vcs1: SUCCESS (2.152s) [65.328297] Starting dynamic subtest: vecs0 [67.437626] Dynamic subtest vecs0: SUCCESS (2.151s) [67.438448] Subtest engines: SUCCESS (10.760s) [67.703518] [014/131] (942s left) gem_softpin (noreloc-interruptible) [67.747743] Starting subtest: noreloc-interruptible [73.160197] Subtest noreloc-interruptible: SUCCESS (5.380s) [73.235777] [015/131] (937s left) gem_exec_reloc (basic-gtt) [73.277708] Starting subtest: basic-gtt [73.283863] Subtest basic-gtt: SUCCESS (0.006s) [73.393312] [016/131] (936s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [73.487759] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [73.489141] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [73.565094] [017/131] (936s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [73.657684] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [73.659056] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [73.723720] [018/131] (936s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [73.814715] Starting subtest: fbc-2p-pri-indfb-multidraw [73.816129] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [73.914964] [019/131] (936s left) perf (non-system-wide-paranoid) [74.011553] Starting subtest: non-system-wide-paranoid [74.051628] Subtest non-system-wide-paranoid: SUCCESS (0.040s) [74.085575] [020/131] (936s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [74.179460] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [74.856817] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (0.677s) [74.995631] [021/131] (935s left) gem_gtt_cpu_tlb [75.109765] [022/131] (935s left) gem_ctx_bad_destroy (invalid-default-ctx) [75.144788] Starting subtest: invalid-default-ctx [75.145587] Subtest invalid-default-ctx: SUCCESS (0.000s) [75.194820] [023/131] (935s left) gem_exec_balancer (parallel-ordering) [75.364354] Subtest parallel-ordering: SKIP (0.000s) [75.428901] [024/131] (935s left) kms_invalid_mode (zero-vdisplay) [75.521536] Starting subtest: zero-vdisplay [75.522287] Starting dynamic subtest: pipe-A-HDMI-A-1 [75.579542] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.058s) [75.584956] Starting dynamic subtest: pipe-B-HDMI-A-1 [75.585718] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [75.591051] Starting dynamic subtest: pipe-C-HDMI-A-1 [75.591803] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [75.597422] Starting dynamic subtest: pipe-D-HDMI-A-1 [75.598165] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [75.598910] Subtest zero-vdisplay: SUCCESS (0.064s) [75.697496] [025/131] (934s left) gem_mmap_offset (isolation) [75.735710] Starting subtest: isolation [75.743637] Subtest isolation: SUCCESS (0.006s) [75.832331] [026/131] (934s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [75.925575] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s) [75.957361] [027/131] (934s left) kms_psr (fbc-psr-primary-blt) [76.046345] Subtest fbc-psr-primary-blt: SKIP (0.000s) [76.082238] [028/131] (934s left) kms_vblank (ts-continuation-idle-hang) [76.173602] Starting subtest: ts-continuation-idle-hang [76.174357] Starting dynamic subtest: pipe-A-HDMI-A-1 [89.784212] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.611s) [89.792338] Starting dynamic subtest: pipe-D-HDMI-A-1 [103.586473] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.799s) [103.587182] Subtest ts-continuation-idle-hang: SUCCESS (27.416s) [103.739690] [029/131] (906s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [103.834466] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [103.864688] [030/131] (906s left) gem_ctx_shared (q-smoketest-all) [103.911838] Starting subtest: Q-smoketest-all [136.200890] Subtest Q-smoketest-all: SUCCESS (32.276s) [136.364735] [031/131] (874s left) perf_pmu (idle-no-semaphores) [136.403108] Starting subtest: idle-no-semaphores [136.403920] Starting dynamic subtest: rcs0 [136.938913] Dynamic subtest rcs0: SUCCESS (0.526s) [136.948014] Starting dynamic subtest: bcs0 [137.467490] Dynamic subtest bcs0: SUCCESS (0.528s) [137.476493] Starting dynamic subtest: vcs0 [137.998425] Dynamic subtest vcs0: SUCCESS (0.531s) [138.007641] Starting dynamic subtest: vcs1 [138.522559] Dynamic subtest vcs1: SUCCESS (0.524s) [138.531708] Starting dynamic subtest: vecs0 [139.042610] Dynamic subtest vecs0: SUCCESS (0.520s) [139.043646] Subtest idle-no-semaphores: SUCCESS (2.631s) [139.103539] [032/131] (871s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [139.197591] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [139.198973] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [139.310404] [033/131] (871s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [139.349177] Starting subtest: etime-single-wait-available-unsubmitted [139.465407] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s) [139.525798] [034/131] (871s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [139.612569] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [139.613583] Starting dynamic subtest: pipe-A [139.774439] Dynamic subtest pipe-A: SUCCESS (0.162s) [139.787046] Starting dynamic subtest: pipe-B [139.923981] Dynamic subtest pipe-B: SUCCESS (0.149s) [139.931909] Starting dynamic subtest: pipe-C [140.058205] Dynamic subtest pipe-C: SUCCESS (0.134s) [140.066303] Starting dynamic subtest: pipe-D [140.199968] Dynamic subtest pipe-D: SUCCESS (0.142s) [140.200696] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.588s) [140.372063] [035/131] (870s left) kms_chamelium_edid (hdmi-edid-read) [140.517220] Subtest hdmi-edid-read: SKIP (0.000s) [140.596119] [036/131] (870s left) drm_fdinfo (context-close-stress) [140.636392] Starting subtest: context-close-stress [151.420162] Subtest context-close-stress: SUCCESS (10.748s) [151.450252] [037/131] (859s left) kms_plane_lowres (tiling-x) [151.539779] Starting subtest: tiling-x [151.540486] Starting dynamic subtest: pipe-A-HDMI-A-1 [158.720504] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.180s) [158.790702] Starting dynamic subtest: pipe-B-HDMI-A-1 [165.773734] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.988s) [165.847831] Starting dynamic subtest: pipe-C-HDMI-A-1 [172.798738] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.955s) [172.880865] Starting dynamic subtest: pipe-D-HDMI-A-1 [179.861745] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (6.985s) [179.926773] Subtest tiling-x: SUCCESS (28.385s) [180.095685] [038/131] (830s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [180.202532] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [180.204055] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [180.284106] [039/131] (830s left) kms_cursor_crc (cursor-sliding-512x170) [180.385818] Starting subtest: cursor-sliding-512x170 [180.387334] Subtest cursor-sliding-512x170: SKIP (0.001s) [180.470633] [040/131] (830s left) kms_frontbuffer_tracking (pipe-fbc-rte) [180.564725] Starting subtest: pipe-fbc-rte [180.568898] Subtest pipe-fbc-rte: SKIP (0.000s) [180.661929] [041/131] (830s left) gem_exec_schedule (wide) [180.840122] Starting subtest: wide [180.842515] Starting dynamic subtest: rcs0 [199.905170] Dynamic subtest rcs0: SUCCESS (19.055s) [199.913164] Starting dynamic subtest: bcs0 [208.696510] Dynamic subtest bcs0: SUCCESS (8.764s) [208.702970] Starting dynamic subtest: vcs0 [218.479119] Dynamic subtest vcs0: SUCCESS (9.807s) [218.487572] Starting dynamic subtest: vcs1 [228.285986] Dynamic subtest vcs1: SUCCESS (9.780s) [228.292355] Starting dynamic subtest: vecs0 [237.746669] Dynamic subtest vecs0: SUCCESS (9.460s) [237.747488] Subtest wide: SUCCESS (56.872s) [239.477410] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true [239.481818] [042/131] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [239.579217] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [239.580674] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [239.674119] [043/131] (771s left) i915_query (query-regions-garbage-items) [239.713083] Starting subtest: query-regions-garbage-items [239.713854] Subtest query-regions-garbage-items: SUCCESS (0.000s) [239.779822] [044/131] (771s left) kms_big_fb (4-tiled-32bpp-rotate-270) [239.879595] Starting subtest: 4-tiled-32bpp-rotate-270 [239.881053] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s) [239.973175] [045/131] (771s left) gem_vm_create (create-ext) [240.012486] Starting subtest: create-ext [240.015197] Subtest create-ext: SUCCESS (0.002s) [240.141594] [046/131] (771s left) kms_pm_rpm (drm-resources-equal) [241.547827] Starting subtest: drm-resources-equal [244.283720] Subtest drm-resources-equal: SUCCESS (2.735s) [244.358210] [047/131] (767s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [244.501475] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [244.589662] [048/131] (766s left) perf (mi-rpc) [244.667052] Starting subtest: mi-rpc [244.668562] Subtest mi-rpc: SKIP (0.000s) [244.705392] [049/131] (766s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [244.743860] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [244.857155] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [244.921792] [050/131] (766s left) kms_flip (2x-plain-flip) [245.011058] Starting subtest: 2x-plain-flip [245.020062] Subtest 2x-plain-flip: SKIP (0.009s) [245.090654] [051/131] (766s left) gem_ctx_param (invalid-param-get) [245.128748] Starting subtest: invalid-param-get [245.129489] Subtest invalid-param-get: SUCCESS (0.000s) [245.188910] [052/131] (766s left) sysfs_heartbeat_interval (nopreempt) [245.229725] Starting subtest: nopreempt [245.231785] Starting dynamic subtest: vecs0 [248.882998] Dynamic subtest vecs0: SUCCESS (3.652s) [248.892796] Starting dynamic subtest: vcs0 [252.545908] Dynamic subtest vcs0: SUCCESS (3.660s) [252.558258] Starting dynamic subtest: bcs0 [256.162622] Dynamic subtest bcs0: SUCCESS (3.615s) [256.173195] Starting dynamic subtest: rcs0 [259.848963] Dynamic subtest rcs0: SUCCESS (3.684s) [259.859578] Starting dynamic subtest: vcs1 [263.464566] Dynamic subtest vcs1: SUCCESS (3.614s) [263.465762] Subtest nopreempt: SUCCESS (18.235s) [263.539807] [053/131] (748s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [263.637077] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [263.638457] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [263.728113] [054/131] (747s left) gem_gpgpu_fill (offset-16x16) [263.766092] Starting subtest: offset-16x16 [263.769865] Subtest offset-16x16: SUCCESS (0.004s) [263.897680] [055/131] (747s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [263.986907] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [263.988277] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [264.149201] [056/131] (747s left) api_intel_bb (simple-bb-ctx) [264.186163] Starting subtest: simple-bb-ctx [264.188736] Subtest simple-bb-ctx: SUCCESS (0.004s) [264.307846] [057/131] (747s left) kms_flip (2x-flip-vs-panning) [264.396663] Starting subtest: 2x-flip-vs-panning [264.405417] Subtest 2x-flip-vs-panning: SKIP (0.009s) [264.474018] [058/131] (747s left) gem_exec_reloc (basic-write-gtt-noreloc) [264.513669] Starting subtest: basic-write-gtt-noreloc [264.516258] Subtest basic-write-gtt-noreloc: SUCCESS (0.003s) [264.628345] [059/131] (747s left) gem_exec_schedule (pi-distinct-iova) [264.804669] Starting subtest: pi-distinct-iova [264.805622] Starting dynamic subtest: rcs0 [264.825183] Dynamic subtest rcs0: SUCCESS (0.020s) [264.832558] Starting dynamic subtest: bcs0 [264.841897] Dynamic subtest bcs0: SUCCESS (0.016s) [264.849870] Starting dynamic subtest: vcs0 [264.861167] Dynamic subtest vcs0: SUCCESS (0.018s) [264.871476] Starting dynamic subtest: vcs1 [264.883652] Dynamic subtest vcs1: SUCCESS (0.021s) [264.893722] Starting dynamic subtest: vecs0 [264.907098] Dynamic subtest vecs0: SUCCESS (0.021s) [264.907857] Subtest pi-distinct-iova: SUCCESS (0.102s) [265.092508] [060/131] (746s left) perf_pmu (busy-double-start) [265.131433] Starting subtest: busy-double-start [265.132211] Starting dynamic subtest: rcs0 [268.687796] Dynamic subtest rcs0: SUCCESS (3.555s) [268.698491] Starting dynamic subtest: bcs0 [272.243952] Dynamic subtest bcs0: SUCCESS (3.553s) [272.255602] Starting dynamic subtest: vcs0 [275.802866] Dynamic subtest vcs0: SUCCESS (3.556s) [275.813243] Starting dynamic subtest: vcs1 [279.371924] Dynamic subtest vcs1: SUCCESS (3.567s) [279.381857] Starting dynamic subtest: vecs0 [282.939827] Dynamic subtest vecs0: SUCCESS (3.565s) [282.941248] Subtest busy-double-start: SUCCESS (17.809s) [283.011379] [061/131] (728s left) kms_plane (plane-panning-bottom-right-suspend) [283.103547] Starting subtest: plane-panning-bottom-right-suspend [283.104252] Starting dynamic subtest: pipe-A [299.653643] Dynamic subtest pipe-A: SUCCESS (1.581s) [299.662696] Starting dynamic subtest: pipe-B [316.650912] Dynamic subtest pipe-B: SUCCESS (1.465s) [316.651619] Subtest plane-panning-bottom-right-suspend: SUCCESS (3.050s) [325.798887] [062/131] (725s left) prime_vgem (busy) [325.868904] Starting subtest: busy [325.869884] Starting dynamic subtest: rcs0 [325.933724] Dynamic subtest rcs0: SUCCESS (0.065s) [325.942258] Starting dynamic subtest: bcs0 [325.956525] Dynamic subtest bcs0: SUCCESS (0.021s) [325.963442] Starting dynamic subtest: vcs0 [325.987704] Dynamic subtest vcs0: SUCCESS (0.030s) [326.003819] Starting dynamic subtest: vcs1 [326.007025] Dynamic subtest vcs1: SUCCESS (0.018s) [326.015962] Starting dynamic subtest: vecs0 [326.023909] Dynamic subtest vecs0: SUCCESS (0.016s) [326.024679] Subtest busy: SUCCESS (0.158s) [326.132684] [063/131] (725s left) gem_exec_fence (syncobj-export) [326.454090] Starting subtest: syncobj-export [326.456313] Subtest syncobj-export: SUCCESS (0.002s) [326.753292] [064/131] (724s left) gem_mmap_gtt (cpuset-medium-copy-xy) [326.790018] Starting subtest: cpuset-medium-copy-XY [338.459626] Subtest cpuset-medium-copy-XY: SUCCESS (11.760s) [338.544129] [065/131] (712s left) gem_exec_reloc (basic-write-read-noreloc) [338.633341] Starting subtest: basic-write-read-noreloc [338.635586] Subtest basic-write-read-noreloc: SUCCESS (0.002s) [338.745448] [066/131] (712s left) gem_exec_capture (pi) [338.786203] Starting subtest: pi [338.787031] Starting dynamic subtest: rcs0 [352.355641] Dynamic subtest rcs0: SUCCESS (13.594s) [352.363745] Starting dynamic subtest: bcs0 [363.148497] Dynamic subtest bcs0: SUCCESS (10.793s) [363.157324] Starting dynamic subtest: vcs0 [373.931749] Dynamic subtest vcs0: SUCCESS (10.781s) [373.940646] Starting dynamic subtest: vcs1 [384.799131] Dynamic subtest vcs1: SUCCESS (10.859s) [384.806382] Starting dynamic subtest: vecs0 [395.553146] Dynamic subtest vecs0: SUCCESS (10.756s) [395.553981] Subtest pi: SUCCESS (56.789s) [395.604535] [067/131] (655s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [395.746605] Starting subtest: primary-yf-tiled-reflect-x-270 [395.798800] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.052s) [395.877142] [068/131] (655s left) kms_psr (psr-primary-render) [395.968605] Subtest psr-primary-render: SKIP (0.000s) [396.010038] [069/131] (655s left) gem_tiled_swapping (non-threaded) [408.726654] Starting subtest: non-threaded [413.508652] Subtest non-threaded: SUCCESS (4.780s) [416.019940] [070/131] (635s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [416.161065] Starting subtest: plane-upscale-20x20-with-modifiers [416.161922] Starting dynamic subtest: pipe-A [416.551985] Dynamic subtest pipe-A: SUCCESS (0.392s) [416.563611] Starting dynamic subtest: pipe-B [416.993050] Dynamic subtest pipe-B: SUCCESS (0.440s) [417.005370] Starting dynamic subtest: pipe-C [417.434886] Dynamic subtest pipe-C: SUCCESS (0.441s) [417.453438] Starting dynamic subtest: pipe-D [417.888151] Dynamic subtest pipe-D: SUCCESS (0.451s) [417.889610] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (1.729s) [418.071799] [071/131] (633s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [418.167379] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [419.494837] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (1.328s) [419.623717] [072/131] (632s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [419.721564] Starting subtest: fbc-rgb101010-draw-pwrite [422.212408] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (2.490s) [422.327283] [073/131] (629s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [422.422584] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [422.424025] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [422.493227] [074/131] (629s left) kms_color (legacy-gamma) [422.583396] Starting subtest: legacy-gamma [422.584242] Starting dynamic subtest: pipe-A-HDMI-A-1 [422.911754] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.327s) [422.921794] Starting dynamic subtest: pipe-B-HDMI-A-1 [423.208095] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.296s) [423.219431] Starting dynamic subtest: pipe-C-HDMI-A-1 [423.518708] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.308s) [423.529013] Starting dynamic subtest: pipe-D-HDMI-A-1 [423.807401] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.287s) [423.808194] Subtest legacy-gamma: SUCCESS (1.224s) [423.936187] [075/131] (628s left) gem_ctx_persistence (engines-persistence) [423.981823] Starting subtest: engines-persistence [423.982589] Starting dynamic subtest: rcs0 [424.778380] Dynamic subtest rcs0: SUCCESS (0.795s) [424.792098] Starting dynamic subtest: bcs0 [425.544250] Dynamic subtest bcs0: SUCCESS (0.763s) [425.556652] Starting dynamic subtest: vcs0 [426.313169] Dynamic subtest vcs0: SUCCESS (0.766s) [426.325358] Starting dynamic subtest: vcs1 [427.082089] Dynamic subtest vcs1: SUCCESS (0.767s) [427.094174] Starting dynamic subtest: vecs0 [427.857230] Dynamic subtest vecs0: SUCCESS (0.773s) [427.858678] Subtest engines-persistence: SUCCESS (3.874s) [427.935435] [076/131] (624s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [427.979786] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [427.980528] Starting dynamic subtest: smem [428.064408] Dynamic subtest smem: SUCCESS (0.084s) [428.065153] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.085s) [428.237696] [077/131] (623s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [428.338547] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [428.726842] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.388s) [428.903005] [078/131] (623s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [428.997603] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [428.999012] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [429.108260] [079/131] (623s left) syncobj_basic (test-valid-cycle) [429.146450] Starting subtest: test-valid-cycle [429.147197] Subtest test-valid-cycle: SUCCESS (0.000s) [429.205439] [080/131] (622s left) i915_pm_rps (thresholds-idle) [429.248383] Starting subtest: thresholds-idle [429.249109] Starting dynamic subtest: gt0 [439.731841] Dynamic subtest gt0: SUCCESS (10.480s) [439.733101] Subtest thresholds-idle: SUCCESS (10.482s) [439.799804] [081/131] (612s left) prime_vgem (coherency-gtt) [439.865719] Starting subtest: coherency-gtt [439.867119] Subtest coherency-gtt: SKIP (0.000s) [439.956485] [082/131] (612s left) kms_flip (basic-flip-vs-modeset) [440.048378] Starting subtest: basic-flip-vs-modeset [440.050285] Starting dynamic subtest: A-HDMI-A1 [440.727258] Dynamic subtest A-HDMI-A1: SUCCESS (0.677s) [440.736296] Starting dynamic subtest: B-HDMI-A1 [441.342588] Dynamic subtest B-HDMI-A1: SUCCESS (0.614s) [441.353626] Starting dynamic subtest: C-HDMI-A1 [442.033953] Dynamic subtest C-HDMI-A1: SUCCESS (0.690s) [442.045286] Starting dynamic subtest: D-HDMI-A1 [442.638941] Dynamic subtest D-HDMI-A1: SUCCESS (0.605s) [442.641494] Subtest basic-flip-vs-modeset: SUCCESS (2.594s) [442.754530] [083/131] (609s left) kms_big_fb (linear-16bpp-rotate-0) [442.862480] Starting subtest: linear-16bpp-rotate-0 [444.142928] Subtest linear-16bpp-rotate-0: SUCCESS (1.280s) [444.309731] [084/131] (608s left) gen9_exec_parse (batch-without-end) [444.352248] Subtest batch-without-end: SKIP (0.000s) [444.398978] [085/131] (607s left) kms_lease (implicit-plane-lease) [444.494548] Starting subtest: implicit-plane-lease [444.495440] Subtest implicit-plane-lease: SUCCESS (0.001s) [444.555456] [086/131] (607s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [444.648584] Starting subtest: psr-2p-scndscrn-spr-indfb-move [444.649999] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [444.732274] [087/131] (607s left) gem_userptr_blits (relocations) [444.772869] Starting subtest: relocations [444.773657] Subtest relocations: SUCCESS (0.002s) [444.905152] [088/131] (607s left) kms_draw_crc (draw-method-mmap-wc) [444.997127] Starting subtest: draw-method-mmap-wc [444.997842] Starting dynamic subtest: xrgb8888-untiled [445.176222] Dynamic subtest xrgb8888-untiled: SUCCESS (0.178s) [445.195847] Starting dynamic subtest: rgb565-untiled [445.342852] Dynamic subtest rgb565-untiled: SUCCESS (0.164s) [445.360933] Starting dynamic subtest: xrgb2101010-untiled [445.501135] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.156s) [445.519002] Starting dynamic subtest: xbgr16161616f-untiled [445.684349] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.181s) [445.701441] Starting dynamic subtest: xrgb8888-xtiled [445.784373] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.098s) [445.802188] Starting dynamic subtest: rgb565-xtiled [445.884410] Dynamic subtest rgb565-xtiled: SUCCESS (0.098s) [445.902504] Starting dynamic subtest: xrgb2101010-xtiled [445.976103] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.089s) [445.993251] Starting dynamic subtest: xbgr16161616f-xtiled [446.076127] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.098s) [446.088991] Starting dynamic subtest: xrgb8888-ytiled [446.168065] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.088s) [446.181880] Starting dynamic subtest: rgb565-ytiled [446.259795] Dynamic subtest rgb565-ytiled: SUCCESS (0.090s) [446.273885] Starting dynamic subtest: xrgb2101010-ytiled [446.351375] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.089s) [446.365272] Starting dynamic subtest: xbgr16161616f-ytiled [446.451265] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.097s) [446.453237] Subtest draw-method-mmap-wc: SUCCESS (1.456s) [446.577355] [089/131] (605s left) kms_fbcon_fbt (psr) [446.618321] Starting subtest: psr [446.619905] Subtest psr: SKIP (0.000s) [446.714920] [090/131] (605s left) gem_ccs (large-ctrl-surf-copy) [446.754016] Starting subtest: large-ctrl-surf-copy [446.755512] Subtest large-ctrl-surf-copy: SKIP (0.000s) [446.816389] [091/131] (605s left) gem_exec_params (rs-invalid) [446.856731] Starting subtest: rs-invalid [446.859036] Subtest rs-invalid: SUCCESS (0.002s) [446.974438] [092/131] (605s left) i915_pm_rc6_residency (rc6-fence) [447.011922] Starting subtest: rc6-fence [447.016171] Starting dynamic subtest: gt0 [465.313069] Dynamic subtest gt0: SUCCESS (18.287s) [465.314223] Subtest rc6-fence: SUCCESS (18.293s) [465.372993] [093/131] (587s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [465.467568] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [465.469017] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [465.574467] [094/131] (587s left) drm_fdinfo (memory-info-shared) [465.613554] Starting subtest: memory-info-shared [465.614319] Starting dynamic subtest: smem0 [465.672253] Dynamic subtest smem0: SUCCESS (0.058s) [465.673119] Subtest memory-info-shared: SUCCESS (0.059s) [465.736829] [095/131] (587s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [465.774812] Starting subtest: multi-wait-for-submit-available-submitted [465.775655] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s) [465.833606] [096/131] (587s left) gem_busy (close-race) [465.881924] Starting subtest: close-race [487.636614] Subtest close-race: SUCCESS (21.758s) [488.023505] [097/131] (564s left) syncobj_wait (invalid-wait-illegal-handle) [488.116487] Starting subtest: invalid-wait-illegal-handle [488.117237] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [488.174184] [098/131] (564s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [488.281696] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [488.283280] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [488.380183] [099/131] (564s left) kms_atomic (plane-cursor-legacy) [488.470943] Starting subtest: plane-cursor-legacy [488.471785] Starting dynamic subtest: pipe-A-HDMI-A-1 [488.635706] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.164s) [488.636433] Subtest plane-cursor-legacy: SUCCESS (0.166s) [488.773238] [100/131] (564s left) gem_mmap_wc (close) [488.812570] Starting subtest: close [488.815220] Subtest close: SUCCESS (0.003s) [488.914535] [101/131] (564s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [489.008547] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [490.227025] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.219s) [490.347560] [102/131] (562s left) kms_vrr (max-min) [490.438714] Starting subtest: max-min [490.440832] Subtest max-min: SKIP (0.000s) [490.496070] [103/131] (562s left) kms_psr (fbc-psr-cursor-plane-move) [490.586099] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s) [490.630570] [104/131] (562s left) gem_userptr_blits (sync-unmap) [490.683574] Starting subtest: sync-unmap [490.698067] Subtest sync-unmap: SUCCESS (0.015s) [490.821429] [105/131] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [490.915489] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [490.916912] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [490.991636] [106/131] (562s left) gem_eio (in-flight-contexts-1us) [491.037025] Starting subtest: in-flight-contexts-1us [504.427253] Subtest in-flight-contexts-1us: SUCCESS (13.390s) [504.547705] [107/131] (548s left) syncobj_timeline (wait-delayed-signal) [504.586105] Starting subtest: wait-delayed-signal [504.688733] Subtest wait-delayed-signal: SUCCESS (0.102s) [504.764403] [108/131] (548s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [504.852480] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs [504.853254] Starting dynamic subtest: pipe-A-HDMI-A-1 [504.860307] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [504.869260] Starting dynamic subtest: pipe-B-HDMI-A-1 [504.876375] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [504.885079] Starting dynamic subtest: pipe-C-HDMI-A-1 [504.892248] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [504.900492] Starting dynamic subtest: pipe-D-HDMI-A-1 [504.907562] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [504.909018] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.008s) [505.090973] [109/131] (548s left) kms_psr (pr-sprite-plane-move) [505.183643] Subtest pr-sprite-plane-move: SKIP (0.000s) [505.230094] [110/131] (548s left) gem_pipe_control_store_loop (reused-buffer) [505.271159] Starting subtest: reused-buffer [507.429937] Subtest reused-buffer: SUCCESS (2.151s) [507.532269] [111/131] (545s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [507.625196] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s) [507.671850] [112/131] (545s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [507.761386] Starting subtest: 2x-long-flip-vs-cursor-legacy [507.764172] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s) [507.819952] [113/131] (545s left) syncobj_timeline (multi-wait-available-submitted) [507.856791] Starting subtest: multi-wait-available-submitted [507.857553] Subtest multi-wait-available-submitted: SUCCESS (0.001s) [507.928691] [114/131] (545s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [508.020336] Starting subtest: fbcpsr-shrfb-scaledprimary [508.021744] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s) [508.123212] [115/131] (545s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [508.168998] Starting subtest: etime-multi-wait-all-submitted-signaled [508.267334] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s) [508.338489] [116/131] (545s left) kms_cursor_crc (cursor-onscreen-max-size) [508.433687] Starting subtest: cursor-onscreen-max-size [508.435802] Subtest cursor-onscreen-max-size: SKIP (0.000s) [508.534571] [117/131] (545s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [508.625355] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [509.908846] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (1.284s) [510.053809] [118/131] (543s left) kms_flip (2x-dpms-vs-vblank-race) [510.146254] Starting subtest: 2x-dpms-vs-vblank-race [510.154621] Subtest 2x-dpms-vs-vblank-race: SKIP (0.009s) [510.220066] [119/131] (543s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [510.312405] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu [510.313877] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [510.414639] [120/131] (543s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling) [510.504368] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling [510.505071] Starting dynamic subtest: pipe-A-valid-mode [511.726485] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.220s) [511.727253] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (1.222s) [511.856404] [121/131] (541s left) gem_exec_whisper (basic-queues-priority-all) [511.905457] Starting subtest: basic-queues-priority-all [514.543021] Subtest basic-queues-priority-all: SUCCESS (2.637s) [514.736067] [122/131] (539s left) api_intel_bb (crc32) [514.773109] Starting subtest: crc32 [514.774577] Subtest crc32: SKIP (0.000s) [514.865003] [123/131] (539s left) kms_flip (blocking-wf_vblank) [514.961282] Starting subtest: blocking-wf_vblank [514.965102] Starting dynamic subtest: A-HDMI-A1 [522.864505] Dynamic subtest A-HDMI-A1: SUCCESS (7.901s) [522.876463] Starting dynamic subtest: B-HDMI-A1 [530.770653] Dynamic subtest B-HDMI-A1: SUCCESS (7.877s) [530.779044] Starting dynamic subtest: C-HDMI-A1 [538.649476] Dynamic subtest C-HDMI-A1: SUCCESS (7.876s) [538.658016] Starting dynamic subtest: D-HDMI-A1 [546.503278] Dynamic subtest D-HDMI-A1: SUCCESS (7.880s) [546.503976] Subtest blocking-wf_vblank: SUCCESS (31.549s) [546.644459] [124/131] (507s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs) [546.739451] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs [546.740238] Starting dynamic subtest: pipe-A-HDMI-A-1 [546.747337] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [546.760529] Starting dynamic subtest: pipe-B-HDMI-A-1 [546.767487] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [546.780676] Starting dynamic subtest: pipe-C-HDMI-A-1 [546.787592] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [546.796193] Starting dynamic subtest: pipe-D-HDMI-A-1 [546.803217] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [546.804586] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.007s) [546.981001] [125/131] (506s left) kms_sequence (get-forked-busy) [547.070786] Starting subtest: get-forked-busy [547.071524] Starting dynamic subtest: pipe-A-HDMI-A-1 [548.389988] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.318s) [548.399363] Starting dynamic subtest: pipe-B-HDMI-A-1 [549.690890] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.299s) [549.703462] Starting dynamic subtest: pipe-C-HDMI-A-1 [550.997011] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.305s) [551.007426] Starting dynamic subtest: pipe-D-HDMI-A-1 [552.290332] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.291s) [552.291070] Subtest get-forked-busy: SUCCESS (5.220s) [552.398718] [126/131] (501s left) kms_pm_rpm (pm-tiling) [553.804307] Starting subtest: pm-tiling [557.695766] Subtest pm-tiling: SUCCESS (3.892s) [557.786894] [127/131] (496s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [557.884751] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [558.243305] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.358s) [558.427133] [128/131] (495s left) kms_cursor_edge_walk (128x128-top-edge) [558.518810] Starting subtest: 128x128-top-edge [558.520947] Starting dynamic subtest: pipe-A-HDMI-A-1 [560.265871] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.745s) [560.276279] Starting dynamic subtest: pipe-D-HDMI-A-1 [561.952477] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.684s) [561.953308] Subtest 128x128-top-edge: SUCCESS (3.434s) [562.055937] [129/131] (492s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [562.151706] Starting subtest: flip-vs-cursor-crc-legacy [562.413783] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.262s) [562.565876] [130/131] (491s left) kms_chamelium_color (ctm-0-50) [562.658230] Subtest ctm-0-50: SKIP (0.000s) [562.699557] [131/131] (491s left) gem_ctx_shared (create-shared-gtt) [562.745075] Starting subtest: create-shared-gtt [564.902813] Subtest create-shared-gtt: SUCCESS (2.149s) [565.084918] Closing watchdogs Done.